-- Logs begin at Tue 2025-09-02 03:32:36 UTC, end at Thu 2025-09-04 03:17:28 UTC. -- Sep 04 03:16:55 ifi-neo-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Sep 04 03:16:55 ifi-neo-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Sep 04 03:16:55 ifi-neo-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 2 milliseconds Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":122745,"duration":255,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4344 Kbps","isStreaming":false,"title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService pause Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stPlaybackTimer Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 37ms Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:16:56 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:16:59 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x162 Sep 04 03:16:59 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:16:59 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:16:59 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:00 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:00 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x162 crc4: 0x4 Sep 04 03:17:00 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:00 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 2 milliseconds Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: 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":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService stop Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stPlaybackTimer Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 45ms Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Clearing queue after UPNP request Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::ClearQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stop Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::clearPlayQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::saveQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushQueue Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: error: updateQueue error: null Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Starting UPNP Playback Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Sent Play Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: Preparing playback through UPNP Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 03:17:06 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Get message: success Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 6ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 89 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 9 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Original Rate 44100 24bit.green.mqa","artist":"MQA Ltd","album":"000 UI","uri":"http://192.168.57.101:16121/local/1db8b8a88e54f8f5f1d1eea7f364c06b.flac","trackType":"flac"} Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus stop Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 118ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Original Rate 44100 24bit.green.mqa","artist":"MQA Ltd","album":"000 UI","uri":"http://192.168.57.101:16121/local/1db8b8a88e54f8f5f1d1eea7f364c06b.flac","trackType":"flac"} Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Received an update from plugin. extracting info from payload Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 101ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:07 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x162 Sep 04 03:17:07 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:07 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:07 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 23ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 16 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":7,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1039 Kbps","isStreaming":false,"title":"Original Rate 44100 24bit.green.mqa","artist":"MQA Ltd","album":"000 UI","uri":"http://192.168.57.101:16121/local/1db8b8a88e54f8f5f1d1eea7f364c06b.flac","trackType":"flac"} Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: Received an update from plugin. extracting info from payload Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 69ms Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:07 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:07 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:07 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:07 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:07 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:08 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:08 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x160 crc4: 0x5 Sep 04 03:17:08 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:08 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:08 ifi-neo-stream3 node[468]: gxl:metadata_handler Sep 04 03:17:08 ifi-neo-stream3 volumio[1330]: info: MetaClient: Sent Meta Sep 04 03:17:08 ifi-neo-stream3 node[468]: metadata.title changed Sep 04 03:17:08 ifi-neo-stream3 node[468]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=230&web=MQA%20Ltd/000%20UI/extralarge Sep 04 03:17:08 ifi-neo-stream3 node[468]: volumio Sep 04 03:17:08 ifi-neo-stream3 volumio[1330]: info: MetaClient: Get message: success Sep 04 03:17:10 ifi-neo-stream3 node[468]: Download data end Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 3 milliseconds Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: 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} Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService stop Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stPlaybackTimer Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 40ms Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:14 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: Clearing queue after UPNP request Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::ClearQueue Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stop Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::clearPlayQueue Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::saveQueue Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushQueue Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: error: updateQueue error: null Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: Starting UPNP Playback Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Sent Play Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: Preparing playback through UPNP Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 03:17:15 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Get message: success Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 6ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 6ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 9ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:16 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 94 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 6 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus stop Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 122ms Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Received an update from plugin. extracting info from payload Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 65ms Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x160 Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 14ms Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 7 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":994,"duration":255,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3388 Kbps","isStreaming":false,"title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: Received an update from plugin. extracting info from payload Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 89ms Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:17 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:17 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x162 crc4: 0x4 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:17 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: MetaClient: Sent Meta Sep 04 03:17:18 ifi-neo-stream3 node[468]: gxl:metadata_handler Sep 04 03:17:18 ifi-neo-stream3 node[468]: metadata.title changed Sep 04 03:17:18 ifi-neo-stream3 node[468]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=230&web=Minnesota%20Orchestra%2C%20Eiji%20Oue/Exotic%20Dances%20From%20The%20Opera/extralarge Sep 04 03:17:18 ifi-neo-stream3 node[468]: volumio Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: MetaClient: Get message: success Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 2 milliseconds Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: 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":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"http://192.168.57.101:16121/local/2bd12a283f1e09f7518663c3fc71d3a8.flac","trackType":"flac"} Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService stop Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stPlaybackTimer Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 47ms Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:18 ifi-neo-stream3 volumio[1330]: info: Clearing queue after UPNP request Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::ClearQueue Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::stop Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::clearPlayQueue Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::saveQueue Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushQueue Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: error: updateQueue error: null Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Starting UPNP Playback Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Sent Play Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Preparing playback through UPNP Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getTrack 0 Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ConvSwitch: Get message: success Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 7ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 6ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 5ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces system playlist update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Ignoring MPD Status Update Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 4ms Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:19 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: ---------------------------- MPD announces state update: player Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 66 milliseconds Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::getState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand status Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand status took 8 milliseconds Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"826 Kbps","isStreaming":false,"title":"被遺忘的時光","artist":"蔡琴","album":"民歌蔡琴","uri":"http://192.168.57.101:16121/local/e36693af7ee33fef0ed1c556f385b1eb.m4a","trackType":"m4a"} Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus stop Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 98ms Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: sendMpdCommand playlistinfo took 12 milliseconds Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: ControllerMpd::parseTrackInfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: ControllerMpd::pushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::servicePushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: In UPNP mode Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":165,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"826 Kbps","isStreaming":false,"title":"被遺忘的時光","artist":"蔡琴","album":"民歌蔡琴","uri":"http://192.168.57.101:16121/local/e36693af7ee33fef0ed1c556f385b1eb.m4a","trackType":"m4a"} Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: verbose: CURRENT POSITION 0 Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState stateService play Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::syncState currentStatus play Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: Received an update from plugin. extracting info from payload Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::pushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioPushState Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: ------------------------------ 79ms Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreCommandRouter::volumioGetQueue Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CoreStateMachine::getQueue Sep 04 03:17:20 ifi-neo-stream3 volumio[1330]: info: CorePlayQueue::getQueue Sep 04 03:17:20 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x162 Sep 04 03:17:20 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:20 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:20 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:20 ifi-neo-stream3 node[468]: Download data end Sep 04 03:17:20 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:20 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x160 crc4: 0x5 Sep 04 03:17:20 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:20 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:21 ifi-neo-stream3 volumio[1330]: info: MetaClient: Sent Meta Sep 04 03:17:21 ifi-neo-stream3 node[468]: gxl:metadata_handler Sep 04 03:17:21 ifi-neo-stream3 node[468]: metadata.title changed Sep 04 03:17:21 ifi-neo-stream3 node[468]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=230&web=%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/extralarge Sep 04 03:17:21 ifi-neo-stream3 node[468]: volumio Sep 04 03:17:21 ifi-neo-stream3 volumio[1330]: info: MetaClient: Get message: success Sep 04 03:17:21 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x160 Sep 04 03:17:21 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x23f crc4: 0x4 Sep 04 03:17:21 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:21 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:21 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x23f Sep 04 03:17:21 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x160 crc4: 0x5 Sep 04 03:17:21 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Sep 04 03:17:21 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: Error: Client network socket disconnected before secure TLS connection was established Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: at connResetException (internal/errors.js:639:14) Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: at TLSSocket.onConnectEnd (_tls_wrap.js:1570:19) Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: at TLSSocket.emit (events.js:412:35) Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: code: 'ECONNRESET', Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: path: null, Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: host: 'lastfm.freetls.fastly.net', Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: port: 443, Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: localAddress: undefined Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: } Sep 04 03:17:27 ifi-neo-stream3 volumio[1330]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 03:17:28 ifi-neo-stream3 sudo[15062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-04 03:16 Sep 04 03:17:28 ifi-neo-stream3 sudo[15062]: 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="d85f549fd57f66fe0d76be73443dfeec10ce0a31" VOLUMIO_FE_VERSION="4d7bdbc050fca4d51b4b6f957a8c16edf3398b14" VOLUMIO_FE3_VERSION="e74dd64a0e70cba17ae236cd366a223f9a1d8528" VOLUMIO_BE_VERSION="f4e24073b9b9ac0aa1c9c308b5a46af10307e1d3" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Sep 2 11:36:30 CST 2025" VOLUMIO_VERSION="0.01.0" VOLUMIO_HARDWARE="neo-stream3" VOLUMIO_DEVICENAME="NEO Stream3" VOLUMIO_HASH="ff96e9964b5536de65270173762f2dd5"