-- Logs begin at Thu 2026-03-05 05:08:05 EST, end at Mon 2026-04-13 10:37:18 EDT. -- Apr 13 10:36:07 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:07 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioAddQueueItems Apr 13 10:36:07 bibi-minidsp volumio[869]: info: CoreStateMachine::addQueueItems Apr 13 10:36:07 bibi-minidsp volumio[869]: info: CorePlayQueue::addQueueItems Apr 13 10:36:07 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:07 bibi-minidsp volumio[869]: info: Adding Item to queue: tidal://mymusic/albums/az/76324167 Apr 13 10:36:07 bibi-minidsp volumio[869]: info: Exploding uri tidal://mymusic/albums/az/76324167 in service tidal Apr 13 10:36:13 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:13 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioAddQueueItems Apr 13 10:36:13 bibi-minidsp volumio[869]: info: CoreStateMachine::addQueueItems Apr 13 10:36:13 bibi-minidsp volumio[869]: info: CorePlayQueue::addQueueItems Apr 13 10:36:13 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:13 bibi-minidsp volumio[869]: info: Adding Item to queue: tidal://mymusic/albums/az/76324167 Apr 13 10:36:13 bibi-minidsp volumio[869]: info: Exploding uri tidal://mymusic/albums/az/76324167 in service tidal Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Apr 13 10:36:17 bibi-minidsp volumio[869]: info: explodeTIDALUri took 9828 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::saveQueue Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrackBlock Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPlay Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: UNSET VOLATILE: Service: undefined Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:17 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::play index 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::stop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::stPlaybackTimer Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrackBlock Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:17 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::serviceStop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::serviceStop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: [1776090977476] ControllerTidal::stop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ControllerMpd::stop Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 67 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::play index undefined Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::startPlaybackTimer Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:17 bibi-minidsp volumio[869]: info: [1776090977556] ControllerTidal::clearAddPlayTrack Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Getting stream with soundQuality HI_RES Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:36:17 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 8 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: sendMpdCommand clear took 9 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" Apr 13 10:36:17 bibi-minidsp volumio[869]: error: updateQueue error: null Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 18ms Apr 13 10:36:17 bibi-minidsp volumio[869]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" took 11 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:36:17 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand play Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: error: Upnp client error: Error: This socket has been ended by the other party Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 28ms Apr 13 10:36:17 bibi-minidsp volumio[869]: info: sendMpdCommand play took 23 milliseconds Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 21ms Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 18ms Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Apr 13 10:36:17 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 10ms Apr 13 10:36:17 bibi-minidsp volumio[869]: info: ------------------------------ 7ms Apr 13 10:36:17 bibi-minidsp volumio[869]: STREAMING PROXY: Handling url /?data=tidal://song/76324168&soundQuality=HI_RES Apr 13 10:36:17 bibi-minidsp volumio[869]: info: Executing endpoint getStreamUrltidal Apr 13 10:36:17 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Apr 13 10:36:18 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Apr 13 10:36:23 bibi-minidsp volumio[869]: info: browseTIDALUri took 6297 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: browseTIDALUri took 5381 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324168 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324169 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324170 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324171 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324172 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324173 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324174 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324175 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324176 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324177 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324178 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324179 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324180 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: explodeTIDALUri took 9864 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::saveQueue Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrackBlock Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPlay Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::play index 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::stop Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::play index undefined Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::startPlaybackTimer Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: [1776090983663] ControllerTidal::clearAddPlayTrack Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Getting stream with soundQuality HI_RES Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:36:23 bibi-minidsp volumio[869]: info: getStreamUrl took 5912 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324168 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324169 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324170 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324171 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324172 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324173 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324174 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324175 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324176 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324177 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324178 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324179 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Preloading song: tidal://song/76324180 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 49 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:23 bibi-minidsp volumio[869]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic1YWExZTNlYjI3MmZlYmM2ZjlmMTg4NmUxYWM2NWMzNV82Mi5tcDQ/0.flac?token=1776094583~OTI2Yzk3YzQyOTJjZmNlYjY4NTU3N2UxNmY1OTZmY2ZjNjZjOTMwOA== Apr 13 10:36:23 bibi-minidsp volumio[869]: STREAMING PROXY: Requesting upstream with range: none Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand status took 34 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand clear took 34 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand status took 28 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand status took 23 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:23 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:23 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 107ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 103ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324168 in service tidal Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324169 in service tidal Apr 13 10:36:23 bibi-minidsp volumio[869]: error: updateQueue error: null Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 111ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 97 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" took 96 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 26ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 24ms Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:36:23 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand play Apr 13 10:36:23 bibi-minidsp volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 158ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: STREAMING PROXY: Handling url /?data=tidal://song/76324168&soundQuality=HI_RES Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Apr 13 10:36:23 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324170 in service tidal Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324171 in service tidal Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 81ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: sendMpdCommand play took 70 milliseconds Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 66ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: ------------------------------ 62ms Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324172 in service tidal Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Executing endpoint getStreamUrltidal Apr 13 10:36:23 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Apr 13 10:36:23 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324173 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324174 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324175 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324176 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324177 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324178 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324179 in service tidal Apr 13 10:36:24 bibi-minidsp volumio[869]: info: Exploding uri tidal://song/76324180 in service tidal Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPlay Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::play index undefined Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::startPlaybackTimer Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: info: [1776090988466] ControllerTidal::clearAddPlayTrack Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Getting stream with soundQuality HI_RES Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 4 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand clear took 6 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:28 bibi-minidsp volumio[869]: error: updateQueue error: null Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand status took 18 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 22ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" took 17 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand status took 13 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand status took 9 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand play Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: 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} Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: No code Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: STREAMING PROXY: Handling url /?data=tidal://song/76324168&soundQuality=HI_RES Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: 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} Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: No code Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: 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} Apr 13 10:36:28 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: No code Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:28 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 226ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 218ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 216ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Apr 13 10:36:28 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 224ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: sendMpdCommand play took 215 milliseconds Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 13ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: ------------------------------ 9ms Apr 13 10:36:28 bibi-minidsp volumio[869]: info: Executing endpoint getStreamUrltidal Apr 13 10:36:28 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Apr 13 10:36:30 bibi-minidsp volumio[869]: info: explodeTIDALUri took 7087 milliseconds Apr 13 10:36:30 bibi-minidsp volumio[869]: info: explodeTIDALUri took 7014 milliseconds Apr 13 10:36:30 bibi-minidsp volumio[869]: info: explodeTIDALUri took 7017 milliseconds Apr 13 10:36:30 bibi-minidsp volumio[869]: info: explodeTIDALUri took 7105 milliseconds Apr 13 10:36:31 bibi-minidsp volumio[869]: info: explodeTIDALUri took 7646 milliseconds Apr 13 10:36:31 bibi-minidsp volumio[869]: info: getStreamUrl took 7971 milliseconds Apr 13 10:36:31 bibi-minidsp volumio[869]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic1YWExZTNlYjI3MmZlYmM2ZjlmMTg4NmUxYWM2NWMzNV82Mi5tcDQ/0.flac?token=1776094583~OTI2Yzk3YzQyOTJjZmNlYjY4NTU3N2UxNmY1OTZmY2ZjNjZjOTMwOA== Apr 13 10:36:31 bibi-minidsp volumio[869]: STREAMING PROXY: Requesting upstream with range: none Apr 13 10:36:31 bibi-minidsp volumio[869]: info: Executing endpoint getSimilarAlbums Apr 13 10:36:31 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Apr 13 10:36:31 bibi-minidsp volumio[869]: info: Executing endpoint metavolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: Executing endpoint getSimilarAlbums Apr 13 10:36:32 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Apr 13 10:36:32 bibi-minidsp volumio[869]: info: Executing endpoint metavolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: Executing endpoint metavolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: Executing endpoint metavolumio Apr 13 10:36:32 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 10:36:33 bibi-minidsp volumio[869]: info: explodeTIDALUri took 9365 milliseconds Apr 13 10:36:35 bibi-minidsp volumio[869]: info: explodeTIDALUri took 11989 milliseconds Apr 13 10:36:35 bibi-minidsp volumio[869]: info: explodeTIDALUri took 11846 milliseconds Apr 13 10:36:36 bibi-minidsp volumio[869]: info: explodeTIDALUri took 11904 milliseconds Apr 13 10:36:36 bibi-minidsp volumio[869]: STREAMING PROXY: Upstream status code: 200 Apr 13 10:36:36 bibi-minidsp volumio[869]: STREAMING PROXY: Upstream status code: 200 Apr 13 10:36:37 bibi-minidsp volumio[869]: info: explodeTIDALUri took 12811 milliseconds Apr 13 10:36:37 bibi-minidsp volumio[869]: info: explodeTIDALUri took 12924 milliseconds Apr 13 10:36:37 bibi-minidsp volumio[869]: info: explodeTIDALUri took 13182 milliseconds Apr 13 10:36:37 bibi-minidsp volumio[869]: info: getStreamUrl took 8799 milliseconds Apr 13 10:36:37 bibi-minidsp volumio[869]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic1YWExZTNlYjI3MmZlYmM2ZjlmMTg4NmUxYWM2NWMzNV82Mi5tcDQ/0.flac?token=1776094583~OTI2Yzk3YzQyOTJjZmNlYjY4NTU3N2UxNmY1OTZmY2ZjNjZjOTMwOA== Apr 13 10:36:37 bibi-minidsp volumio[869]: STREAMING PROXY: Requesting upstream with range: none Apr 13 10:36:39 bibi-minidsp volumio[869]: error: Failed request for metavolumio API Apr 13 10:36:39 bibi-minidsp volumio[869]: error: Failed request for metavolumio API Apr 13 10:36:39 bibi-minidsp volumio[869]: error: Failed request for metavolumio API Apr 13 10:36:39 bibi-minidsp volumio[869]: error: Failed request for metavolumio API Apr 13 10:36:39 bibi-minidsp volumio[869]: info: explodeTIDALUri took 15629 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: STREAMING PROXY: Upstream status code: 200 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 18 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 21 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 15 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus stop Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 49ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Apr 13 10:36:44 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 29 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 10 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand status took 7 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Received an update from plugin. extracting info from payload Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Received an update from plugin. extracting info from payload Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 191ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 186ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 138 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 135 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 135 milliseconds Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Received an update from plugin. extracting info from payload Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Received an update from plugin. extracting info from payload Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":46,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"76324168&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES","trackType":"tidal"} Apr 13 10:36:44 bibi-minidsp volumio[869]: verbose: CURRENT POSITION 0 Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState stateService play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::syncState currentStatus play Apr 13 10:36:44 bibi-minidsp volumio[869]: info: Received an update from plugin. extracting info from payload Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:36:44 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 325ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 305ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: ------------------------------ 304ms Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumiosetSourceActiveno-source Apr 13 10:36:44 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 10:36:44 bibi-minidsp volumio[869]: Cannot find translation for source Presets Apr 13 10:36:44 bibi-minidsp volumio[869]: Cannot find translation for source TIDAL Apr 13 10:36:47 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:47 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioAddQueueItems Apr 13 10:36:47 bibi-minidsp volumio[869]: info: CoreStateMachine::addQueueItems Apr 13 10:36:47 bibi-minidsp volumio[869]: info: CorePlayQueue::addQueueItems Apr 13 10:36:47 bibi-minidsp volumio[869]: info: Preload queue cleared Apr 13 10:36:47 bibi-minidsp volumio[869]: info: Adding Item to queue: tidal://album/76324167 Apr 13 10:36:47 bibi-minidsp volumio[869]: info: Exploding uri tidal://album/76324167 in service tidal Apr 13 10:36:55 bibi-minidsp volumio[869]: verbose: New Socket.io Connection to 10.0.0.28 from 10.0.0.84 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 7 Apr 13 10:36:57 bibi-minidsp volumio[869]: verbose: New Socket.io Connection to 10.0.0.28 from 10.0.0.84 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 8 Apr 13 10:37:00 bibi-minidsp volumio[869]: verbose: New Socket.io Connection to 10.0.0.28 from 10.0.0.84 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 9 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: explodeTIDALUri took 14970 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushQueue Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::saveQueue Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrackBlock Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPlay Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::play index 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::stop Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::stPlaybackTimer Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::updateTrackBlock Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrackBlock Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::serviceStop Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::serviceStop Apr 13 10:37:02 bibi-minidsp volumio[869]: info: [1776091022795] ControllerTidal::stop Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::stop Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:37:02 bibi-minidsp volumio[869]: STREAMING PROXY: Client closed connection Apr 13 10:37:02 bibi-minidsp volumio[869]: STREAMING PROXY: Upstream closed. Received 3270041 bytes Apr 13 10:37:02 bibi-minidsp volumio[869]: STREAMING PROXY: Incomplete transfer. Expected 17215763, got 3270041 Apr 13 10:37:02 bibi-minidsp volumio[869]: STREAMING PROXY: Retrying with range: bytes=3270041- (attempt 1) Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Apr 13 10:37:02 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 55 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::play index undefined Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::startPlaybackTimer Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: [1776091022862] ControllerTidal::clearAddPlayTrack Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Getting stream with soundQuality HI_RES Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand status took 12 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand stop took 5 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Apr 13 10:37:02 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Apr 13 10:37:02 bibi-minidsp volumio[869]: ---------------------------- MPD announces state update: player Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::getState Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand status Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Apr 13 10:37:02 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand clear took 18 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand status took 11 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: info: sendMpdCommand status took 8 milliseconds Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseTrackInfo Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:37:02 bibi-minidsp volumio[869]: verbose: ControllerMpd::parseState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 13 10:37:02 bibi-minidsp volumio[869]: info: ControllerMpd::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::servicePushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreStateMachine::pushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioPushState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CoreCommandRouter::volumioGetState Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output update for this device Apr 13 10:37:02 bibi-minidsp volumio[869]: info: MRS: Pushing multiroomSync output Apr 13 10:37:02 bibi-minidsp volumio[869]: info: CorePlayQueue::getTrack 0 Apr 13 10:37:02 bibi-minidsp volumio[869]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 148ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 122ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 118ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Apr 13 10:37:03 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Apr 13 10:37:03 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:03 bibi-minidsp volumio[869]: error: updateQueue error: null Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Apr 13 10:37:03 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 130ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/76324168&soundQuality=HI_RES" took 122 milliseconds Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 16ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 13ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 13 10:37:03 bibi-minidsp volumio[869]: verbose: ControllerMpd::sendMpdCommand play Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Apr 13 10:37:03 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Apr 13 10:37:03 bibi-minidsp volumio[869]: ---------------------------- MPD announces system playlist update Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Ignoring MPD Status Update Apr 13 10:37:03 bibi-minidsp volumio[869]: STREAMING PROXY: Handling url /?data=tidal://song/76324168&soundQuality=HI_RES Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 69ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: sendMpdCommand play took 62 milliseconds Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 61ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: ------------------------------ 57ms Apr 13 10:37:03 bibi-minidsp volumio[869]: info: Executing endpoint getStreamUrltidal Apr 13 10:37:03 bibi-minidsp volumio[869]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Apr 13 10:37:03 bibi-minidsp volumio[869]: STREAMING PROXY: Resuming with range: bytes=3270041- Apr 13 10:37:06 bibi-minidsp volumio[869]: STREAMING PROXY: Resume upstream status code: 206 Apr 13 10:37:13 bibi-minidsp volumio[869]: info: getStreamUrl took 10117 milliseconds Apr 13 10:37:13 bibi-minidsp volumio[869]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic1YWExZTNlYjI3MmZlYmM2ZjlmMTg4NmUxYWM2NWMzNV82Mi5tcDQ/0.flac?token=1776094583~OTI2Yzk3YzQyOTJjZmNlYjY4NTU3N2UxNmY1OTZmY2ZjNjZjOTMwOA== Apr 13 10:37:13 bibi-minidsp volumio[869]: STREAMING PROXY: Requesting upstream with range: none Apr 13 10:37:17 bibi-minidsp volumio[869]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:37:17 bibi-minidsp volumio[869]: Error: read ECONNRESET Apr 13 10:37:17 bibi-minidsp volumio[869]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Apr 13 10:37:17 bibi-minidsp volumio[869]: errno: -104, Apr 13 10:37:17 bibi-minidsp volumio[869]: code: 'ECONNRESET', Apr 13 10:37:17 bibi-minidsp volumio[869]: syscall: 'read' Apr 13 10:37:17 bibi-minidsp volumio[869]: } Apr 13 10:37:17 bibi-minidsp volumio[869]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:37:18 bibi-minidsp sudo[32284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-13 10:36 Apr 13 10:37:18 bibi-minidsp sudo[32284]: 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="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 11:08:05 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="2435172a9e07e22ce77410ca4817b0fa"