-- Logs begin at Sat 2025-12-13 22:48:32 CET, end at Mon 2025-12-15 17:10:42 CET. -- Dec 15 17:09:00 g.a.minidspshd volumio[15703]: info: browseTIDALUri took 274 milliseconds Dec 15 17:09:00 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:00 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: browseTIDALUri took 318 milliseconds Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/91696366 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68678745 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68714205 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68713122 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68714168 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68685052 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/68685495 Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/91696366 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68678745 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68714205 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68713122 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68714168 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 219 milliseconds Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68685052 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 232 milliseconds Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/68685495 in service tidal Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 263 milliseconds Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 247 milliseconds Dec 15 17:09:10 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 241 milliseconds Dec 15 17:09:11 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 243 milliseconds Dec 15 17:09:11 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 267 milliseconds Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioAddQueueItems Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: CoreStateMachine::addQueueItems Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: CorePlayQueue::addQueueItems Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: Adding Item to queue: tidal://playlist/06a797b9-d88d-4536-8732-39e1f1bfa9e8 Dec 15 17:09:12 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://playlist/06a797b9-d88d-4536-8732-39e1f1bfa9e8 in service tidal Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 328 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushQueue Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::saveQueue Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPlay Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: UNSET VOLATILE: Service: inputs Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index 0 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stPlaybackTimer Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 5 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::serviceStop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 5 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::serviceStop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: [1765814953179] ControllerTidal::stop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ControllerMpd::stop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 51 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index undefined Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::startPlaybackTimer Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: [1765814953242] ControllerTidal::clearAddPlayTrack Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Getting stream with soundQuality LOSSLESS Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 8 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand clear Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: sendMpdCommand clear took 11 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS" Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: error: updateQueue error: null Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 42ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS" took 36 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 35ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 33ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:09:13 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand play Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:13 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: STREAMING PROXY: Handling url /?data=tidal://song/91696366&soundQuality=LOSSLESS Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 21ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: sendMpdCommand play took 12 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 11ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: ------------------------------ 8ms Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: Executing endpoint getStreamUrltidal Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Dec 15 17:09:13 g.a.minidspshd volumio[15703]: info: getStreamUrl took 529 milliseconds Dec 15 17:09:13 g.a.minidspshd volumio[15703]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2YWZkNDBmM2FhNmUxZWNkNTE4NDU2NmJhMzA1NDIyMl82MS5tcDQ/0.flac?token=1765818553~NzBjNDJmNDc4NmVmMjRkNDE1NmRlYzg3NjIyMTJlODQ1MWIwYTQ3Ng== Dec 15 17:09:14 g.a.minidspshd volumio[15703]: STREAMING PROXY: Response: 200, length: 32568432 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 13 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 10 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 7 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:14 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 28 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 12 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 9 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 138ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 193ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 193ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 166 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 155 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 155 milliseconds Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"91696366&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/91696366&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:14 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 418ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 399ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: info: ------------------------------ 400ms Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:14 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:15 g.a.minidspshd volumio[15703]: STREAMING PROXY: Client dropped request, destroying Dec 15 17:09:18 g.a.minidspshd volumiologrotate[514]: ls: cannot access '/var/log/samba/log.wb-G.A.': No such file or directory Dec 15 17:09:18 g.a.minidspshd volumiologrotate[514]: ls: cannot access '(MINIDSP_SHD)': No such file or directory Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioAddQueueItems Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::addQueueItems Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::addQueueItems Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Adding Item to queue: tidal://song/68685052 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Using cached record of: tidal://song/68685052 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushQueue Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::saveQueue Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPlay Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stPlaybackTimer Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::serviceStop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::serviceStop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: [1765814962503] ControllerTidal::stop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::stop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 37 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index undefined Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::startPlaybackTimer Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioGetVisibleSources Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: [1765814962552] ControllerTidal::clearAddPlayTrack Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Getting stream with soundQuality LOSSLESS Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 4 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand clear Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 15 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand clear took 14 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 11 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 9 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS" Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 52ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 50ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: error: updateQueue error: null Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 61ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 55 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS" took 54 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 17ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 15ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:09:22 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand play Dec 15 17:09:22 g.a.minidspshd volumio[15703]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 85ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: STREAMING PROXY: Handling url /?data=tidal://song/68685052&soundQuality=LOSSLESS Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:22 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:22 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 48ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: sendMpdCommand play took 40 milliseconds Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 36ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: ------------------------------ 32ms Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: Executing endpoint getStreamUrltidal Dec 15 17:09:22 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: getStreamUrl took 463 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiQ3ZDVlMjUzOGNjM2U1MGIwMWFhZmY0Y2QzYzYyZWZkMy5tcDQ/0.flac?token=1765818563~NmMwZGY5MGU0MTNmYjZhM2QzNzc2ZDgyMTFhOGJkODYxNTQ0ODkxMQ== Dec 15 17:09:23 g.a.minidspshd volumio[15703]: STREAMING PROXY: Response: 200, length: 125317202 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 13 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 10 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 7 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:23 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 28 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 23 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 14 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 8 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 119ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 170ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 168ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 133 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 128 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 128 milliseconds Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":1098,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:23 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 333ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 319ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: info: ------------------------------ 316ms Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:23 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 86 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 87 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 85 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: Setting Spotify Volume from Volumio: 85 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:26 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 17:09:26 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 85 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 84 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 85 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 84 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: SPOTIFY VOLUME 85 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: VOLUMIO VOLUME 82 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 15 17:09:27 g.a.minidspshd volumio[15703]: info: Setting Spotify Volume from Volumio: 82 Dec 15 17:09:27 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:29 g.a.minidspshd volumio[15703]: SPOTIFY: SETTING SPOTIFY VOLUME 82 Dec 15 17:09:29 g.a.minidspshd volumio[15703]: info: Sending Spotify command with payload to local API: /player/volume Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioRandom Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::writePlayerControls Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setRepeat true single true Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:40 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:40 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:40 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: METAVOLUMIO: Enabling Infinity Playback Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioGetState Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioGetVisibleSources Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioRandom Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::writePlayerControls Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setRepeat false single false Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:41 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:41 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:41 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:41 g.a.minidspshd volumio[15703]: STREAMING PROXY: Client dropped request, destroying Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: my_music , getSuperSearchEnabledSourcesList Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioGetBrowseSources Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioGetBrowseSources Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: All cached search sources collected Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982077] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982081] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982084] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982086] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982089] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982099] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982101] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982104] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982106] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982109] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982111] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982113] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982116] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982118] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982121] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982124] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982126] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982129] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982131] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: [1765814982134] ControllerCalmRadio::searchCategories Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: METAVOLUMIO: Disabling Infinity Playback Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioRandom Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::writePlayerControls Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setRepeat false single false Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:42 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:42 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:42 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioClearQueue Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::ClearQueue Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stPlaybackTimer Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::serviceStop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::serviceStop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: [1765814983117] ControllerTidal::stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::clearPlayQueue Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::saveQueue Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushQueue Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:43 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 110 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 2 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:43 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: Dec 15 17:09:43 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 7 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 4 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: 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":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: No code Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ------------------------------ 68ms Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 44 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 44 milliseconds Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: 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":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: No code Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: 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":"68685052&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/68685052&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:09:43 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 7 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: No code Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ------------------------------ 138ms Dec 15 17:09:43 g.a.minidspshd volumio[15703]: info: ------------------------------ 136ms Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:43 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:09:56 g.a.minidspshd volumio[15703]: Searching plugin music_service/tidal Dec 15 17:09:56 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , search Dec 15 17:09:57 g.a.minidspshd volumio[15703]: info: searchTIDALUri took 569 milliseconds Dec 15 17:09:57 g.a.minidspshd volumio[15703]: info: search took 573 milliseconds Dec 15 17:09:57 g.a.minidspshd volumio[15703]: info: All search sources collected, pushing search results Dec 15 17:09:57 g.a.minidspshd volumio[15703]: Searching plugin music_service/tidal Dec 15 17:09:57 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , search Dec 15 17:09:58 g.a.minidspshd volumio[15703]: info: searchTIDALUri took 451 milliseconds Dec 15 17:09:58 g.a.minidspshd volumio[15703]: info: search took 454 milliseconds Dec 15 17:09:58 g.a.minidspshd volumio[15703]: info: All search sources collected, pushing search results Dec 15 17:10:00 g.a.minidspshd volumio[15703]: Searching plugin music_service/tidal Dec 15 17:10:00 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , search Dec 15 17:10:00 g.a.minidspshd volumio[15703]: info: searchTIDALUri took 456 milliseconds Dec 15 17:10:00 g.a.minidspshd volumio[15703]: info: search took 458 milliseconds Dec 15 17:10:00 g.a.minidspshd volumio[15703]: info: All search sources collected, pushing search results Dec 15 17:10:18 g.a.minidspshd volumiologrotate[514]: ls: cannot access '/var/log/samba/log.wb-G.A.': No such file or directory Dec 15 17:10:18 g.a.minidspshd volumiologrotate[514]: ls: cannot access '(MINIDSP_SHD)': No such file or directory Dec 15 17:10:34 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioAddQueueItems Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: CoreStateMachine::addQueueItems Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: CorePlayQueue::addQueueItems Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Adding Item to queue: tidal://artist/19852081 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://artist/19852081 in service tidal Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: browseTIDALUri took 1521 milliseconds Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preload queue cleared Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498888 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498885 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498886 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498889 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498887 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498892 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498895 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498891 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498890 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498929 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498893 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498905 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498921 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498901 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498900 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498894 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333577 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498923 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498902 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333580 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333581 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498899 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333576 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498896 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498898 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498909 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498897 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498907 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498926 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498903 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498908 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498914 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333584 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498925 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498911 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333586 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498932 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333585 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333587 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333590 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333593 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333589 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498912 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498920 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498904 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/286498934 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333595 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333594 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333601 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Preloading song: tidal://song/227333597 Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498888 in service tidal Dec 15 17:10:35 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498885 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498886 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498889 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498887 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 241 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498892 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498895 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 289 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498891 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 258 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498890 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 297 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498929 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 684 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushQueue Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CorePlayQueue::saveQueue Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::updateTrackBlock Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrackBlock Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPlay Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index 0 Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::stop Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::play index undefined Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreStateMachine::startPlaybackTimer Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: [1765815036578] ControllerTidal::clearAddPlayTrack Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Getting stream with soundQuality LOSSLESS Dec 15 17:10:36 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 352 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 449 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498893 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498905 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498921 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498901 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 337 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 425 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: sendMpdCommand stop took 188 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand clear Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498900 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498894 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333577 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498923 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:36 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: sendMpdCommand clear took 101 milliseconds Dec 15 17:10:36 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS" Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Executing endpoint getSimilarArtists Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:36 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:36 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498902 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333580 in service tidal Dec 15 17:10:36 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333581 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: error: updateQueue error: null Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:37 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 142ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS" took 139 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 98ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 93ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 17:10:37 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand play Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:37 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: STREAMING PROXY: Handling url /?data=tidal://song/286498888&soundQuality=LOSSLESS Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:37 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces system playlist update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Ignoring MPD Status Update Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Executing endpoint getSimilarArtists Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Executing endpoint metavolumio Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Executing endpoint metavolumio Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498899 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333576 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498896 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498898 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498909 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 216ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: sendMpdCommand play took 199 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 195ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: ------------------------------ 192ms Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 892 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 825 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498897 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498907 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498926 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Executing endpoint getStreamUrltidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498903 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498908 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498914 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 923 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 925 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 927 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 929 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333584 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498925 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 812 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 812 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 814 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 815 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498911 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333586 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498932 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 823 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 822 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 821 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333585 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333587 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333590 in service tidal Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 752 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 753 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 757 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 760 milliseconds Dec 15 17:10:37 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 620 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333593 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333589 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 694 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 695 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498912 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498920 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 930 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498904 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 730 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 732 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/286498934 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333595 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 632 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 758 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 642 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333594 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333601 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 603 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 606 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: getStreamUrl took 937 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMGJlNTM0MWY1MjJjYTg1ZGVlZTk2NTNjOWI0NzM1NV82MS5tcDQ/0.flac?token=1765818638~ZWRmYzQ5MDM5ZTk2YWQyYWQ2Y2FhZmE4MDkwYzhjOTVkMTgyY2E3NQ== Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Exploding uri tidal://song/227333597 in service tidal Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 520 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 703 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 596 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 611 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 535 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 567 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 557 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: STREAMING PROXY: Response: 200, length: 21195467 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 16 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 12 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 8 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Dec 15 17:10:38 g.a.minidspshd volumio[15703]: ---------------------------- MPD announces state update: player Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::getState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand status Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 629 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 583 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 52 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 46 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 45 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 44 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 39 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand status took 35 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"134 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus stop Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"117 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"117 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ------------------------------ 158ms Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ------------------------------ 192ms Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ------------------------------ 188ms Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 636 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 645 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 158 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 151 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: sendMpdCommand playlistinfo took 150 milliseconds Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: ControllerMpd::parseTrackInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"117 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"117 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: ControllerMpd::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::servicePushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CorePlayQueue::getTrack 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"117 Kbps","isStreaming":false,"title":"286498888&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/286498888&soundQuality=LOSSLESS","trackType":"tidal"} Dec 15 17:10:38 g.a.minidspshd volumio[15703]: verbose: CURRENT POSITION 0 Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState stateService play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::syncState currentStatus play Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: Received an update from plugin. extracting info from payload Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreStateMachine::pushState Dec 15 17:10:38 g.a.minidspshd volumio[15703]: info: CoreCommandRouter::volumioPushState Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: ------------------------------ 361ms Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: ------------------------------ 346ms Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: ------------------------------ 344ms Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 704 milliseconds Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 637 milliseconds Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 15 17:10:39 g.a.minidspshd volumio[15703]: info: explodeTIDALUri took 815 milliseconds Dec 15 17:10:41 g.a.minidspshd volumio[15703]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 17:10:41 g.a.minidspshd volumio[15703]: TypeError: Cannot read property 'slice' of null Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at Object.onceWrapper (events.js:520:26) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at ClientRequest.emit (events.js:400:28) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at TLSSocket.socketOnData (_http_client.js:515:22) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at TLSSocket.emit (events.js:400:28) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at addChunk (internal/streams/readable.js:293:12) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: at readableAddChunk (internal/streams/readable.js:267:9) Dec 15 17:10:41 g.a.minidspshd volumio[15703]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 17:10:41 g.a.minidspshd volumio[15703]: STREAMING PROXY: Client dropped request, destroying Dec 15 17:10:42 g.a.minidspshd sudo[2438]: volumio : unable to resolve host g.a.minidspshd Dec 15 17:10:42 g.a.minidspshd sudo[2438]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Dec 15 17:10:42 g.a.minidspshd sudo[2438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 17:09 Dec 15 17:10:42 g.a.minidspshd sudo[2438]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 18 Nov 2025 04:27:40 PM CET" VOLUMIO_VERSION="3.877" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="861d146b0ca5e28d2e157bf87e6b15ea"