-- Logs begin at Tue 2024-05-14 05:36:54 UTC, end at Tue 2024-05-14 06:37:30 UTC. -- May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::volumioNext May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:06 tidal volumio[824]: info: [1715668566502] ControllerTidal::next May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:36:06 tidal volumio[824]: info: [1715668566504] ControllerTidal::stop May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:06 tidal volumio[824]: info: ControllerMpd::stop May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:06 tidal volumio[824]: info: May 14 06:36:06 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand stop took 91 milliseconds May 14 06:36:06 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:06 tidal volumio[824]: info: [1715668566596] ControllerTidal::clearAddPlayTrack May 14 06:36:06 tidal volumio[824]: info: Getting stream with soundQuality LOSSLESS May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand stop took 1 milliseconds May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:06 tidal volumio[824]: info: May 14 06:36:06 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:06 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand clear took 0 milliseconds May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/23755133" May 14 06:36:06 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:06 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:06 tidal volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd May 14 06:36:06 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:06 tidal volumio[824]: error: updateQueue error: null May 14 06:36:06 tidal volumio[824]: info: May 14 06:36:06 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:06 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:06 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/23755133" took 4 milliseconds May 14 06:36:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:06 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/23755133 May 14 06:36:06 tidal volumio[824]: info: ------------------------------ 3ms May 14 06:36:06 tidal volumio[824]: info: sendMpdCommand play took 3 milliseconds May 14 06:36:06 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:06 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:07 tidal volumio[824]: info: getStreamUrl took 604 milliseconds May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInNzllNWQ4YThlYTE5MTJiZjQzNzEyMTk3YjQzZjc1NzNfNjEubXA0/0.flac?token=1715672167~OGI5N2ExOWU4MGRlNTBkZThiNzQ0ZGRmZTljZGI4MTRjMjkzM2Q3NQ== May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:36:07 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:07 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/23755133","service":"tidal","name":"Take a look (Acoustic)","title":"Take a look (Acoustic)","album":"The Acoustic Album","type":"track","tracknumber":5,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/de361990/8011/4a32/8b31/11009798680b/640x640.jpg","duration":282,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Level 42","artistUri":"tidal://artist/26327","albumUri":"tidal://album/23755128","audioQuality":"LOSSLESS"} May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:07 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:07 tidal volumio[824]: info: [1715668567370] ControllerTidal::seek May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:07 tidal volumio[824]: info: ControllerMpd::seek May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:07 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:07 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 32422385 May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/23755133 May 14 06:36:07 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:07 tidal volumio[824]: info: getStreamUrl took 325 milliseconds May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInNzllNWQ4YThlYTE5MTJiZjQzNzEyMTk3YjQzZjc1NzNfNjEubXA0/0.flac?token=1715672167~OGI5N2ExOWU4MGRlNTBkZThiNzQ0ZGRmZTljZGI4MTRjMjkzM2Q3NQ== May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Got range request: bytes=10049108- May 14 06:36:07 tidal volumio[824]: STREAMING PROXY: Response: 206, length: 22373277 May 14 06:36:07 tidal volumio[824]: error: null May 14 06:36:07 tidal volumio[824]: info: May 14 06:36:07 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:07 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:07 tidal volumio[824]: info: May 14 06:36:07 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:07 tidal volumio[824]: info: sendMpdCommand status took 4 milliseconds May 14 06:36:07 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:07 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:07 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:07 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:07 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:07 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89000,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"23755133","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/23755133","trackType":"tidal"} May 14 06:36:07 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:07 tidal volumio[824]: info: ------------------------------ 7ms May 14 06:36:07 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:07 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:07 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:07 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:07 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89000,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"23755133","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/23755133","trackType":"tidal"} May 14 06:36:07 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:07 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:07 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:07 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:07 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:07 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:07 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:08 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::volumioPause May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::pause May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::servicePause May 14 06:36:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::servicePause May 14 06:36:12 tidal volumio[824]: info: [1715668572385] ControllerTidal::pause May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:12 tidal volumio[824]: info: ControllerMpd::pause May 14 06:36:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand pause May 14 06:36:12 tidal volumio[824]: info: May 14 06:36:12 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:12 tidal volumio[824]: info: sendMpdCommand pause took 63 milliseconds May 14 06:36:12 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:12 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:12 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:12 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:12 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:12 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:12 tidal volumio[824]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":94964,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"23755133","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/23755133","trackType":"tidal"} May 14 06:36:12 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::syncState stateService pause May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus pause May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:12 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:12 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:12 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:12 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:12 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:17 tidal ntpd[1949]: 86.80.166.233 local addr 192.168.178.23 -> May 14 06:36:29 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri May 14 06:36:30 tidal volumio[824]: info: browseTIDALUri took 335 milliseconds May 14 06:36:30 tidal volumio[824]: info: Preload queue cleared May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543860 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543861 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543862 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543863 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543864 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543865 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543866 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543867 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543868 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543869 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543870 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543871 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543872 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543873 May 14 06:36:30 tidal volumio[824]: info: Preloading song: tidal://song/119543874 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543860 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543861 in service tidal May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543862 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543863 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543864 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543865 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543866 in service tidal May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 322 milliseconds May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543867 in service tidal May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 327 milliseconds May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543868 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543869 in service tidal May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 324 milliseconds May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543870 in service tidal May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543871 in service tidal May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 379 milliseconds May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 330 milliseconds May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543872 in service tidal May 14 06:36:30 tidal volumio[824]: info: Preload queue cleared May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::ClearQueue May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:36:30 tidal volumio[824]: info: [1715668590966] ControllerTidal::stop May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:30 tidal volumio[824]: info: ControllerMpd::stop May 14 06:36:30 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::clearPlayQueue May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::addQueueItems May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::addQueueItems May 14 06:36:30 tidal volumio[824]: info: Preload queue cleared May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543860 May 14 06:36:30 tidal volumio[824]: info: Using cached record of: tidal://song/119543860 May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543861 May 14 06:36:30 tidal volumio[824]: info: Using cached record of: tidal://song/119543861 May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543862 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543862 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543863 May 14 06:36:30 tidal volumio[824]: info: Using cached record of: tidal://song/119543863 May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543864 May 14 06:36:30 tidal volumio[824]: info: Using cached record of: tidal://song/119543864 May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543865 May 14 06:36:30 tidal volumio[824]: info: Using cached record of: tidal://song/119543865 May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543866 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543866 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543867 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543867 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543868 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543868 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543869 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543869 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543870 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543870 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543871 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543871 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543872 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543872 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543873 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543873 in service tidal May 14 06:36:30 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543874 May 14 06:36:30 tidal volumio[824]: info: Exploding uri tidal://song/119543874 in service tidal May 14 06:36:30 tidal volumio[824]: info: May 14 06:36:30 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:30 tidal volumio[824]: info: sendMpdCommand stop took 20 milliseconds May 14 06:36:30 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:30 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:30 tidal volumio[824]: info: explodeTIDALUri took 355 milliseconds May 14 06:36:30 tidal volumio[824]: info: sendMpdCommand status took 2 milliseconds May 14 06:36:30 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:30 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:30 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:30 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:30 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:30 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:36:30 tidal volumio[824]: 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":"23755133","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/23755133","trackType":"tidal"} May 14 06:36:30 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::syncState stateService stop May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:30 tidal volumio[824]: info: No code May 14 06:36:30 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:30 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:30 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:30 tidal volumio[824]: info: ------------------------------ 9ms May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 344 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 324 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 650 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 327 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 318 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 318 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 241 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 246 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 249 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 250 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 252 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 258 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 267 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 276 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 315 milliseconds May 14 06:36:31 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 416 milliseconds May 14 06:36:31 tidal volumio[824]: info: explodeTIDALUri took 427 milliseconds May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPlay May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::play index 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: info: [1715668591399] ControllerTidal::clearAddPlayTrack May 14 06:36:31 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand stop took 1 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:31 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand clear took 1 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" May 14 06:36:31 tidal volumio[824]: error: updateQueue error: null May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:31 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" took 2 milliseconds May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 1ms May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand play took 0 milliseconds May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543861 May 14 06:36:31 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:31 tidal volumio[824]: info: Preload queue cleared May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::ClearQueue May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::clearPlayQueue May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::addQueueItems May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::addQueueItems May 14 06:36:31 tidal volumio[824]: info: Preload queue cleared May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543860 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543860 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543861 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543861 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543862 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543862 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543863 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543863 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543864 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543864 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543865 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543865 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543866 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543866 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543867 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543867 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543868 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543868 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543869 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543869 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543870 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543870 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543871 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543871 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543872 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543872 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543873 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543873 May 14 06:36:31 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543874 May 14 06:36:31 tidal volumio[824]: info: Using cached record of: tidal://song/119543874 May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPlay May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::play index 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: info: [1715668591557] ControllerTidal::clearAddPlayTrack May 14 06:36:31 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand stop took 1 milliseconds May 14 06:36:31 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:31 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand clear took 1 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" May 14 06:36:31 tidal volumio[824]: error: updateQueue error: null May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:31 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 1ms May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" took 0 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:31 tidal volumio[824]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 3ms May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543861 May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand play took 0 milliseconds May 14 06:36:31 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:31 tidal volumio[824]: info: getStreamUrl took 328 milliseconds May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOTdjNDQyMGVmMjgyMmM2ZmJmNGVjYWFhMzkzYWJkYWZfNjEubXA0/0.flac?token=1715672191~ZDRiZDUzNThmMDliYjYzNjM0NmRkOTE3ZTA2NDU1OWIwYTZiNjk1Mw== May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 14011084 May 14 06:36:31 tidal volumio[824]: info: getStreamUrl took 321 milliseconds May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOTdjNDQyMGVmMjgyMmM2ZmJmNGVjYWFhMzkzYWJkYWZfNjEubXA0/0.flac?token=1715672191~ZDRiZDUzNThmMDliYjYzNjM0NmRkOTE3ZTA2NDU1OWIwYTZiNjk1Mw== May 14 06:36:31 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 14011084 May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:31 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand status took 5 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:31 tidal volumio[824]: info: May 14 06:36:31 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:31 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:31 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:31 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 6ms May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:31 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:31 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:31 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:31 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:31 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:31 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:31 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:31 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:31 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:31 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:31 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:31 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:32 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:32 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:32 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:32 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:32 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:32 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:33 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:33 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:33 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:33 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:33 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:33 tidal volumio[824]: info: Executing endpoint metavolumio May 14 06:36:33 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 14 06:36:34 tidal volumio[824]: info: Preload queue cleared May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::ClearQueue May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:34 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:34 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:36:34 tidal volumio[824]: info: [1715668594697] ControllerTidal::stop May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:34 tidal volumio[824]: info: ControllerMpd::stop May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::clearPlayQueue May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::addQueueItems May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::addQueueItems May 14 06:36:34 tidal volumio[824]: info: Preload queue cleared May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543860 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543860 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543861 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543861 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543862 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543862 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543863 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543863 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543864 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543864 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543865 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543865 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543866 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543866 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543867 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543867 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543868 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543868 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543869 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543869 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543870 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543870 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543871 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543871 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543872 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543872 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543873 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543873 May 14 06:36:34 tidal volumio[824]: info: Adding Item to queue: tidal://song/119543874 May 14 06:36:34 tidal volumio[824]: info: Using cached record of: tidal://song/119543874 May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::volumioPushQueue May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::saveQueue May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::volumioPlay May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::play index 1 May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:34 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:34 tidal volumio[824]: info: [1715668594704] ControllerTidal::clearAddPlayTrack May 14 06:36:34 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:34 tidal volumio[824]: info: May 14 06:36:34 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand stop took 29 milliseconds May 14 06:36:34 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand stop took 24 milliseconds May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:34 tidal volumio[824]: info: May 14 06:36:34 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:34 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand clear took 0 milliseconds May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" May 14 06:36:34 tidal volumio[824]: error: updateQueue error: null May 14 06:36:34 tidal volumio[824]: info: May 14 06:36:34 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:34 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:34 tidal volumio[824]: info: ------------------------------ 1ms May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543861" took 1 milliseconds May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:34 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:34 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:34 tidal volumio[824]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 14 06:36:34 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:36:34 tidal volumio[824]: info: ------------------------------ 0ms May 14 06:36:34 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543861 May 14 06:36:34 tidal volumio[824]: info: sendMpdCommand play took 1 milliseconds May 14 06:36:34 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:34 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:35 tidal volumio[824]: info: getStreamUrl took 316 milliseconds May 14 06:36:35 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOTdjNDQyMGVmMjgyMmM2ZmJmNGVjYWFhMzkzYWJkYWZfNjEubXA0/0.flac?token=1715672191~ZDRiZDUzNThmMDliYjYzNjM0NmRkOTE3ZTA2NDU1OWIwYTZiNjk1Mw== May 14 06:36:35 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 14011084 May 14 06:36:35 tidal volumio[824]: info: May 14 06:36:35 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:35 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:35 tidal volumio[824]: info: May 14 06:36:35 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:35 tidal volumio[824]: info: sendMpdCommand status took 5 milliseconds May 14 06:36:35 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:35 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:35 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:35 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:35 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:35 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:35 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:35 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:35 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:35 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:35 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:35 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:35 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:35 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:35 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:35 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:35 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:35 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:35 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:35 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:35 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:35 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:35 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:35 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:35 tidal volumio[824]: info: ------------------------------ 8ms May 14 06:36:35 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:36 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:37 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:36:37 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:37 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543861","service":"tidal","name":"Constructive Interference","title":"Constructive Interference","album":"Stay Tuned!","type":"track","tracknumber":2,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":139,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:37 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:37 tidal volumio[824]: info: [1715668597267] ControllerTidal::seek May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:37 tidal volumio[824]: info: ControllerMpd::seek May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:37 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:37 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:37 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:37 tidal volumio[824]: error: null May 14 06:36:37 tidal volumio[824]: info: May 14 06:36:37 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:37 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:37 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:37 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:37 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:37 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:37 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:37 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:37 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:37 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:37 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:37 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"699 Kbps","isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:37 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:37 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:37 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:37 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:37 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:37 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:37 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:42 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:36:42 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:42 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543861","service":"tidal","name":"Constructive Interference","title":"Constructive Interference","album":"Stay Tuned!","type":"track","tracknumber":2,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":139,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:42 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:42 tidal volumio[824]: info: [1715668602201] ControllerTidal::seek May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:42 tidal volumio[824]: info: ControllerMpd::seek May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:42 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:42 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:42 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:42 tidal volumio[824]: error: null May 14 06:36:42 tidal volumio[824]: info: May 14 06:36:42 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:42 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:42 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:42 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:42 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:42 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:42 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:42 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:42 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:42 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:42 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:42 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"693 Kbps","isStreaming":false,"title":"119543861","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543861","trackType":"tidal"} May 14 06:36:42 tidal volumio[824]: verbose: CURRENT POSITION 1 May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:42 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:42 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:42 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:42 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:42 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:42 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::volumioNext May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:44 tidal volumio[824]: info: [1715668604535] ControllerTidal::next May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 1 May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:36:44 tidal volumio[824]: info: [1715668604537] ControllerTidal::stop May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::stop May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:44 tidal volumio[824]: info: May 14 06:36:44 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand stop took 19 milliseconds May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: info: [1715668604556] ControllerTidal::clearAddPlayTrack May 14 06:36:44 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand stop took 0 milliseconds May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:44 tidal volumio[824]: info: May 14 06:36:44 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:44 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand clear took 1 milliseconds May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543862" May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd May 14 06:36:44 tidal volumio[824]: info: ------------------------------ 6ms May 14 06:36:44 tidal volumio[824]: error: updateQueue error: null May 14 06:36:44 tidal volumio[824]: info: May 14 06:36:44 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:44 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:44 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543862" took 4 milliseconds May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:44 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543862 May 14 06:36:44 tidal volumio[824]: info: ------------------------------ 3ms May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand play took 2 milliseconds May 14 06:36:44 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:44 tidal volumio[824]: info: getStreamUrl took 323 milliseconds May 14 06:36:44 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInMDI0ZDZjODEyMWY5Y2NmNTFhMmE2ZDY4ZjE4NmUzYWVfNjEubXA0/0.flac?token=1715672204~ODIwZGEzNWZiMDUwMzkwMmJiN2ExYTc2NjlkZTdlYTkyZGRkNjgwZA== May 14 06:36:44 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 18800315 May 14 06:36:44 tidal volumio[824]: info: May 14 06:36:44 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:44 tidal volumio[824]: info: May 14 06:36:44 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand status took 5 milliseconds May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543862","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543862","trackType":"tidal"} May 14 06:36:44 tidal volumio[824]: verbose: CURRENT POSITION 2 May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:44 tidal volumio[824]: info: ------------------------------ 7ms May 14 06:36:44 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:44 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:44 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:44 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:44 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"119543862","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543862","trackType":"tidal"} May 14 06:36:44 tidal volumio[824]: verbose: CURRENT POSITION 2 May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:44 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:44 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:44 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:44 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:44 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:45 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:45 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:36:45 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:45 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543862","service":"tidal","name":"Where There Is Smoke","title":"Where There Is Smoke","album":"Stay Tuned!","type":"track","tracknumber":3,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":210,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:45 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:45 tidal volumio[824]: info: [1715668605466] ControllerTidal::seek May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:45 tidal volumio[824]: info: ControllerMpd::seek May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:45 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:45 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:45 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:45 tidal volumio[824]: error: null May 14 06:36:45 tidal volumio[824]: info: May 14 06:36:45 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:45 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:45 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:45 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:45 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:45 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:45 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:45 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:45 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:45 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:45 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:45 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":53000,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"350 Kbps","isStreaming":false,"title":"119543862","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543862","trackType":"tidal"} May 14 06:36:45 tidal volumio[824]: verbose: CURRENT POSITION 2 May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:45 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:45 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:45 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:45 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:45 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:45 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::volumioNext May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:52 tidal volumio[824]: info: [1715668612232] ControllerTidal::next May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::next May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 2 May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:36:52 tidal volumio[824]: info: [1715668612234] ControllerTidal::stop May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::stop May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:52 tidal volumio[824]: info: May 14 06:36:52 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand stop took 125 milliseconds May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: info: [1715668612360] ControllerTidal::clearAddPlayTrack May 14 06:36:52 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand stop took 0 milliseconds May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:36:52 tidal volumio[824]: info: May 14 06:36:52 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:52 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand clear took 1 milliseconds May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543863" May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd May 14 06:36:52 tidal volumio[824]: info: ------------------------------ 7ms May 14 06:36:52 tidal volumio[824]: error: updateQueue error: null May 14 06:36:52 tidal volumio[824]: info: May 14 06:36:52 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:36:52 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:36:52 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543863" took 5 milliseconds May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:36:52 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543863 May 14 06:36:52 tidal volumio[824]: info: ------------------------------ 3ms May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand play took 2 milliseconds May 14 06:36:52 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:52 tidal volumio[824]: info: getStreamUrl took 324 milliseconds May 14 06:36:52 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOWM1ZGJmZmIyNWY1MjkyYzQzMTIxMjQ1ZDE3ODRiOTRfNjEubXA0/0.flac?token=1715672212~MzlmODI1NGM5M2NiODdmMjFkMmUwMDQ5MWY0NWFiMjBlZmZhMmIyYQ== May 14 06:36:52 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 26105987 May 14 06:36:52 tidal volumio[824]: info: May 14 06:36:52 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:52 tidal volumio[824]: info: May 14 06:36:52 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand status took 5 milliseconds May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:52 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:52 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543863","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543863","trackType":"tidal"} May 14 06:36:52 tidal volumio[824]: verbose: CURRENT POSITION 3 May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:36:52 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:52 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:52 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543863","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543863","trackType":"tidal"} May 14 06:36:52 tidal volumio[824]: verbose: CURRENT POSITION 3 May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:52 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:52 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:52 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:52 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:52 tidal volumio[824]: info: ------------------------------ 8ms May 14 06:36:52 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:36:53 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:36:53 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:53 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543863","service":"tidal","name":"There Is Probably Fire","title":"There Is Probably Fire","album":"Stay Tuned!","type":"track","tracknumber":4,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":250,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:36:53 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:53 tidal volumio[824]: info: [1715668613219] ControllerTidal::seek May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:36:53 tidal volumio[824]: info: ControllerMpd::seek May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:53 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:53 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:53 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:53 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:36:53 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543863 May 14 06:36:53 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:36:53 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:36:53 tidal volumio[824]: info: getStreamUrl took 326 milliseconds May 14 06:36:53 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOWM1ZGJmZmIyNWY1MjkyYzQzMTIxMjQ1ZDE3ODRiOTRfNjEubXA0/0.flac?token=1715672212~MzlmODI1NGM5M2NiODdmMjFkMmUwMDQ5MWY0NWFiMjBlZmZhMmIyYQ== May 14 06:36:53 tidal volumio[824]: STREAMING PROXY: Got range request: bytes=7004947- May 14 06:36:53 tidal volumio[824]: STREAMING PROXY: Response: 206, length: 19101040 May 14 06:36:53 tidal volumio[824]: error: null May 14 06:36:53 tidal volumio[824]: info: May 14 06:36:53 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:36:53 tidal volumio[824]: info: ControllerMpd::getState May 14 06:36:53 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:36:53 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:36:53 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:36:53 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:36:53 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:36:53 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:36:53 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:36:53 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:36:53 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:36:53 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67000,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"742 Kbps","isStreaming":false,"title":"119543863","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543863","trackType":"tidal"} May 14 06:36:53 tidal volumio[824]: verbose: CURRENT POSITION 3 May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:36:53 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:36:53 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:36:53 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:36:53 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:36:53 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:36:53 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:36:55 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:37:04 tidal ntpd[1949]: ntpd exiting on signal 15 (Terminated) May 14 06:37:04 tidal ntpd[1949]: 45.138.55.61 local addr 192.168.178.23 -> May 14 06:37:04 tidal systemd[1]: Stopping Network Time Service... May 14 06:37:04 tidal ntpd[1949]: 37.34.56.75 local addr 192.168.178.23 -> May 14 06:37:04 tidal systemd[1]: ntp.service: Succeeded. May 14 06:37:04 tidal ntpd[1949]: 81.172.225.142 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 83.137.149.135 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 185.159.125.100 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 94.198.159.11 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 45.138.55.62 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 5.255.124.190 local addr 192.168.178.23 -> May 14 06:37:04 tidal systemd[1]: Stopped Network Time Service. May 14 06:37:04 tidal ntpd[1949]: 94.198.159.16 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 193.123.56.220 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 94.198.159.15 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 158.101.216.150 local addr 192.168.178.23 -> May 14 06:37:04 tidal ntpd[1949]: 178.215.228.24 local addr 192.168.178.23 -> May 14 06:37:04 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:04 tidal systemd[1]: Starting Network Time Service... May 14 06:37:04 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 14 06:37:04 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:04 tidal ntpd[2209]: ntpd 4.2.8p12@1.3728-o (1): Starting May 14 06:37:04 tidal ntpd[2209]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 14 06:37:04 tidal systemd[1]: Started Network Time Service. May 14 06:37:04 tidal ntpd[2215]: proto: precision = 0.106 usec (-23) May 14 06:37:04 tidal ntpd[2215]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 14 06:37:04 tidal ntpd[2215]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 14 06:37:04 tidal ntpd[2215]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 504 days ago May 14 06:37:04 tidal ntpd[2215]: Listen and drop on 0 v6wildcard [::]:123 May 14 06:37:04 tidal ntpd[2215]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 14 06:37:04 tidal ntpd[2215]: Listen normally on 2 lo 127.0.0.1:123 May 14 06:37:04 tidal ntpd[2215]: Listen normally on 3 eth0 192.168.178.23:123 May 14 06:37:04 tidal ntpd[2215]: Listen normally on 4 wlan0 192.168.211.1:123 May 14 06:37:04 tidal ntpd[2215]: Listen normally on 5 wlan0 169.254.113.248:123 May 14 06:37:04 tidal ntpd[2215]: Listening on routing socket on fd #22 for interface updates May 14 06:37:04 tidal ntpd[2215]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 14 06:37:04 tidal ntpd[2215]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 14 06:37:05 tidal ntpd[2215]: Soliciting pool server 45.138.55.60 May 14 06:37:06 tidal ntpd[2215]: Soliciting pool server 213.109.127.82 May 14 06:37:06 tidal ntpd[2215]: Soliciting pool server 87.238.174.133 May 14 06:37:06 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:37:06 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:37:06 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543863","service":"tidal","name":"There Is Probably Fire","title":"There Is Probably Fire","album":"Stay Tuned!","type":"track","tracknumber":4,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":250,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:37:06 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:37:06 tidal volumio[824]: info: [1715668626810] ControllerTidal::seek May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:06 tidal volumio[824]: info: ControllerMpd::seek May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:06 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:06 tidal volumio[824]: error: null May 14 06:37:06 tidal volumio[824]: info: May 14 06:37:06 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:06 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:06 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:06 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:06 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:06 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:37:06 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:06 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:06 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:06 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:37:06 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":115000,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"580 Kbps","isStreaming":false,"title":"119543863","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543863","trackType":"tidal"} May 14 06:37:06 tidal volumio[824]: verbose: CURRENT POSITION 3 May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:37:06 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:37:06 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:06 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:06 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:06 tidal volumio[824]: info: ------------------------------ 9ms May 14 06:37:07 tidal ntpd[2215]: Soliciting pool server 86.80.166.233 May 14 06:37:07 tidal ntpd[2215]: Soliciting pool server 5.255.99.180 May 14 06:37:07 tidal ntpd[2215]: Soliciting pool server 178.215.228.24 May 14 06:37:08 tidal ntpd[2215]: Soliciting pool server 188.166.95.178 May 14 06:37:08 tidal ntpd[2215]: Soliciting pool server 213.136.0.252 May 14 06:37:08 tidal ntpd[2215]: Soliciting pool server 185.51.192.63 May 14 06:37:08 tidal ntpd[2215]: Soliciting pool server 5.255.124.190 May 14 06:37:09 tidal ntpd[2215]: Soliciting pool server 185.51.192.61 May 14 06:37:09 tidal ntpd[2215]: Soliciting pool server 77.174.62.158 May 14 06:37:09 tidal ntpd[2215]: Soliciting pool server 162.159.200.123 May 14 06:37:10 tidal ntpd[2215]: Soliciting pool server 185.51.192.62 May 14 06:37:11 tidal ntpd[2215]: Soliciting pool server 193.123.37.231 May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::volumioNext May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::next May 14 06:37:12 tidal volumio[824]: info: [1715668632150] ControllerTidal::next May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::next May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 3 May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:37:12 tidal volumio[824]: info: [1715668632152] ControllerTidal::stop May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::stop May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand stop took 111 milliseconds May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:12 tidal volumio[824]: info: [1715668632263] ControllerTidal::clearAddPlayTrack May 14 06:37:12 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:37:12 tidal volumio[824]: info: May 14 06:37:12 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand stop took 1 milliseconds May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:37:12 tidal volumio[824]: info: May 14 06:37:12 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:37:12 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand clear took 0 milliseconds May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543864" May 14 06:37:12 tidal volumio[824]: error: updateQueue error: null May 14 06:37:12 tidal volumio[824]: info: May 14 06:37:12 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:37:12 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:37:12 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand playlistinfo took 2 milliseconds May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543864" took 2 milliseconds May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:37:12 tidal volumio[824]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 14 06:37:12 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:37:12 tidal volumio[824]: info: ------------------------------ 1ms May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand play took 1 milliseconds May 14 06:37:12 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543864 May 14 06:37:12 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:37:12 tidal volumio[824]: info: getStreamUrl took 327 milliseconds May 14 06:37:12 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInMGFmMDhmODliOWUyZTJhZWE1NmNlMDg3MWVjYTkzMzZfNjEubXA0/0.flac?token=1715672232~M2Q2YWI4ZDg3YzdhMGE1ODJkZGNlMTRhM2E2MzFlYTg2ODg3MmQ1NA== May 14 06:37:12 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 18109527 May 14 06:37:12 tidal volumio[824]: info: May 14 06:37:12 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:12 tidal volumio[824]: info: May 14 06:37:12 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand status took 2 milliseconds May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:12 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543864","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543864","trackType":"tidal"} May 14 06:37:12 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:37:12 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:37:12 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:37:12 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:12 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:12 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:12 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543864","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543864","trackType":"tidal"} May 14 06:37:12 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:37:12 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:37:12 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:12 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:12 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:12 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:37:12 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:37:13 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:37:13 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:13 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543864","service":"tidal","name":"Gun Burial","title":"Gun Burial","album":"Stay Tuned!","type":"track","tracknumber":5,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":184,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:37:13 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:13 tidal volumio[824]: info: [1715668633103] ControllerTidal::seek May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:13 tidal volumio[824]: info: ControllerMpd::seek May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:13 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:13 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:13 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:13 tidal volumio[824]: error: null May 14 06:37:13 tidal volumio[824]: info: May 14 06:37:13 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:13 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:13 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:13 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:13 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:13 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:13 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:37:13 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:13 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:13 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:13 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:13 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48000,"duration":184,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"552 Kbps","isStreaming":false,"title":"119543864","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543864","trackType":"tidal"} May 14 06:37:13 tidal volumio[824]: verbose: CURRENT POSITION 4 May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:37:13 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:37:13 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:13 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:13 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:13 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:13 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:37:14 tidal ntpd[2215]: Soliciting pool server 95.85.21.89 May 14 06:37:14 tidal ntpd[2215]: Soliciting pool server 51.159.236.138 May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::volumioNext May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::next May 14 06:37:14 tidal volumio[824]: info: [1715668634840] ControllerTidal::next May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::next May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::stop May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:14 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:14 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::serviceStop May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 4 May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::serviceStop May 14 06:37:14 tidal volumio[824]: info: [1715668634842] ControllerTidal::stop May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:14 tidal volumio[824]: info: ControllerMpd::stop May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:37:14 tidal volumio[824]: info: May 14 06:37:14 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand stop took 105 milliseconds May 14 06:37:14 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::play index undefined May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:14 tidal volumio[824]: info: [1715668634948] ControllerTidal::clearAddPlayTrack May 14 06:37:14 tidal volumio[824]: info: Getting stream with soundQuality HI_RES May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand stop May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::updateTrackBlock May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrackBlock May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand stop took 0 milliseconds May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand clear May 14 06:37:14 tidal volumio[824]: info: May 14 06:37:14 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:37:14 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand playlistinfo took 1 milliseconds May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand clear took 1 milliseconds May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543865" May 14 06:37:14 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:14 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:14 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:14 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:14 tidal volumio[824]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd May 14 06:37:14 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:37:14 tidal volumio[824]: error: updateQueue error: null May 14 06:37:14 tidal volumio[824]: info: May 14 06:37:14 tidal volumio[824]: ---------------------------- MPD announces system playlist update May 14 06:37:14 tidal volumio[824]: info: Ignoring MPD Status Update May 14 06:37:14 tidal volumio[824]: info: ------------------------------ 3ms May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/119543865" took 3 milliseconds May 14 06:37:14 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:14 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand play May 14 06:37:14 tidal volumio[824]: STREAMING PROXY: Handling url /?data=tidal://song/119543865 May 14 06:37:14 tidal volumio[824]: info: ------------------------------ 2ms May 14 06:37:14 tidal volumio[824]: info: sendMpdCommand play took 2 milliseconds May 14 06:37:14 tidal volumio[824]: info: Executing endpoint getStreamUrltidal May 14 06:37:14 tidal volumio[824]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 14 06:37:15 tidal ntpd[2215]: Soliciting pool server 94.198.159.15 May 14 06:37:15 tidal ntpd[2215]: Soliciting pool server 149.210.142.45 May 14 06:37:15 tidal volumio[824]: info: getStreamUrl took 347 milliseconds May 14 06:37:15 tidal volumio[824]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInODdiNzE5ZTkwMzJmMWFhNTJiYWUyNGY1YjM1NGNmZjhfNjEubXA0/0.flac?token=1715672235~YzZmYzEzZDU4YzZkZjk0NmQ2OTdkMzllMzAzZDgxYWMxZjhmYTM3NA== May 14 06:37:15 tidal volumio[824]: STREAMING PROXY: Response: 200, length: 17343507 May 14 06:37:15 tidal volumio[824]: info: May 14 06:37:15 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:15 tidal volumio[824]: info: May 14 06:37:15 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand status took 5 milliseconds May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:15 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:15 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543865","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543865","trackType":"tidal"} May 14 06:37:15 tidal volumio[824]: verbose: CURRENT POSITION 5 May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus stop May 14 06:37:15 tidal volumio[824]: info: ------------------------------ 6ms May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:15 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:15 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"119543865","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543865","trackType":"tidal"} May 14 06:37:15 tidal volumio[824]: verbose: CURRENT POSITION 5 May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:37:15 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:15 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:37:15 tidal volumio[824]: STREAMING PROXY: Client dropped request, destroying May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::volumioSeek May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::seek May 14 06:37:15 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:15 tidal volumio[824]: info: TRACKBLOCK {"uri":"tidal://song/119543865","service":"tidal","name":"Big Man Do Cry","title":"Big Man Do Cry","album":"Stay Tuned!","type":"track","tracknumber":6,"volumeNumber":1,"albumart":"https://resources.tidal.com/images/f77fc28b/c025/424e/82cf/790200f18679/640x640.jpg","duration":195,"trackType":"tidal","samplerate":"44.1 KHz","bitdepth":"16 bit","explicit":false,"artist":"Dominique Fils-Aimé","artistUri":"tidal://artist/9054764","albumUri":"tidal://album/119543859","audioQuality":"HI_RES"} May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::startPlaybackTimer May 14 06:37:15 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:15 tidal volumio[824]: info: [1715668635826] ControllerTidal::seek May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::seek May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:15 tidal volumio[824]: error: null May 14 06:37:15 tidal volumio[824]: info: May 14 06:37:15 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand status took 0 milliseconds May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:15 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:37:15 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:15 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:15 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:15 tidal volumio[824]: verbose: STATE SERVICE {"status":"play","position":0,"seek":55000,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"645 Kbps","isStreaming":false,"title":"119543865","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543865","trackType":"tidal"} May 14 06:37:15 tidal volumio[824]: verbose: CURRENT POSITION 5 May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState stateService play May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus play May 14 06:37:15 tidal volumio[824]: info: Received an update from plugin. extracting info from payload May 14 06:37:15 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:15 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:15 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:15 tidal volumio[824]: info: ------------------------------ 4ms May 14 06:37:26 tidal volumio[824]: info: CoreCommandRouter::volumioPause May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::pause May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::servicePause May 14 06:37:26 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:26 tidal volumio[824]: info: CoreCommandRouter::servicePause May 14 06:37:26 tidal volumio[824]: info: [1715668646114] ControllerTidal::pause May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::setConsumeUpdateService mpd May 14 06:37:26 tidal volumio[824]: info: ControllerMpd::pause May 14 06:37:26 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand pause May 14 06:37:26 tidal volumio[824]: info: May 14 06:37:26 tidal volumio[824]: ---------------------------- MPD announces state update: player May 14 06:37:26 tidal volumio[824]: info: sendMpdCommand pause took 26 milliseconds May 14 06:37:26 tidal volumio[824]: info: ControllerMpd::getState May 14 06:37:26 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand status May 14 06:37:26 tidal volumio[824]: info: sendMpdCommand status took 1 milliseconds May 14 06:37:26 tidal volumio[824]: verbose: ControllerMpd::parseState May 14 06:37:26 tidal volumio[824]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 14 06:37:26 tidal volumio[824]: info: sendMpdCommand playlistinfo took 0 milliseconds May 14 06:37:26 tidal volumio[824]: verbose: ControllerMpd::parseTrackInfo May 14 06:37:26 tidal volumio[824]: info: ControllerMpd::pushState May 14 06:37:26 tidal volumio[824]: info: CoreCommandRouter::servicePushState May 14 06:37:26 tidal volumio[824]: info: CorePlayQueue::getTrack 5 May 14 06:37:26 tidal volumio[824]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":66588,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"959 Kbps","isStreaming":false,"title":"119543865","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/119543865","trackType":"tidal"} May 14 06:37:26 tidal volumio[824]: verbose: CURRENT POSITION 5 May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::syncState stateService pause May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::syncState currentStatus pause May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::pushState May 14 06:37:26 tidal volumio[824]: info: CoreCommandRouter::volumioPushState May 14 06:37:26 tidal volumio[824]: info: MRS: Pushing multiroomSync output update for this device May 14 06:37:26 tidal volumio[824]: info: MRS: Pushing multiroomSync output May 14 06:37:26 tidal volumio[824]: info: CoreStateMachine::stPlaybackTimer May 14 06:37:26 tidal volumio[824]: info: ------------------------------ 5ms May 14 06:37:30 tidal volumio[824]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ May 14 06:37:30 tidal volumio[824]: info: PLUGIN onShutdown : networkfs May 14 06:37:30 tidal sudo[2227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl poweroff May 14 06:37:30 tidal sudo[2227]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 06:37:30 tidal systemd-logind[380]: System is powering down. May 14 06:37:30 tidal sudo[2227]: pam_unix(sudo:session): session closed for user root May 14 06:37:30 tidal systemd[1]: Stopped target RPC Port Mapper. May 14 06:37:30 tidal systemd[1]: Stopping RealtimeKit Scheduling Policy Service... May 14 06:37:30 tidal systemd[1]: Stopped target Host and Network Name Lookups. May 14 06:37:30 tidal systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... May 14 06:37:30 tidal systemd[1]: Stopped target Timers. May 14 06:37:30 tidal systemd[1]: apt-daily-upgrade.timer: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Daily apt upgrade and clean activities. May 14 06:37:30 tidal systemd[1]: man-db.timer: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Daily man-db regeneration. May 14 06:37:30 tidal systemd[1]: systemd-tmpfiles-clean.timer: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Daily Cleanup of Temporary Directories. May 14 06:37:30 tidal systemd[1]: Stopped target Bluetooth. May 14 06:37:30 tidal bluetoothd[462]: Terminating May 14 06:37:30 tidal systemd[1]: Stopping Bluetooth service... May 14 06:37:30 tidal systemd[1]: Unmounting RPC Pipe File System... May 14 06:37:30 tidal systemd[1]: Stopping Volumio Bluetooth Module... May 14 06:37:30 tidal autossh[1716]: received signal to exit (15) May 14 06:37:30 tidal systemd[1]: Stopping MyVolumio SSH Tunnel... May 14 06:37:30 tidal systemd[1]: Stopping Authorization Manager... May 14 06:37:30 tidal volumiobt[2233]: Killing pulse May 14 06:37:30 tidal systemd[1]: Stopping Volumio Tidal Connect Service... May 14 06:37:30 tidal systemd[1]: apt-daily.timer: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Daily apt download activities. May 14 06:37:30 tidal systemd[1]: Stopped target System Time Synchronized. May 14 06:37:30 tidal systemd[1]: systemd-rfkill.socket: Succeeded. May 14 06:37:30 tidal systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. May 14 06:37:30 tidal systemd[1]: Stopped target Graphical Interface. May 14 06:37:30 tidal systemd[1]: Stopped target Multi-User System. May 14 06:37:30 tidal systemd[1]: Stopping Samba SMB Daemon... May 14 06:37:30 tidal systemd[1]: Stopping UPnP Renderer front-end to MPD... May 14 06:37:30 tidal systemd[1]: Stopping LSB: set CPUFreq kernel parameters... May 14 06:37:30 tidal startx[826]: xinit: connection to X server lost May 14 06:37:30 tidal startx[826]: [1B blob data] May 14 06:37:30 tidal systemd[1]: Stopped target Login Prompts. May 14 06:37:30 tidal systemd[1]: Stopping Getty on tty1... May 14 06:37:30 tidal systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 14 06:37:30 tidal systemd[1]: Stopping triggerhappy global hotkey daemon... May 14 06:37:30 tidal systemd[1]: Stopping Start Volumio Kiosk... May 14 06:37:30 tidal dhcpcd[422]: received SIGTERM, stopping May 14 06:37:30 tidal systemd[1]: Stopping DHCP Client Daemon... May 14 06:37:30 tidal dhcpcd[422]: wlan0: removing interface May 14 06:37:30 tidal systemd[1]: Stopping Network Time Service... May 14 06:37:30 tidal ntpd[2215]: ntpd exiting on signal 15 (Terminated) May 14 06:37:30 tidal ntpd[2215]: 45.138.55.60 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 213.109.127.82 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 87.238.174.133 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 5.255.99.180 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 86.80.166.233 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 178.215.228.24 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 213.136.0.252 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 185.51.192.63 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 188.166.95.178 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 5.255.124.190 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 185.51.192.61 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 185.51.192.62 local addr 192.168.178.23 -> May 14 06:37:30 tidal systemd[1]: Stopping Login Service... May 14 06:37:30 tidal ntpd[2215]: 193.123.37.231 local addr 192.168.178.23 -> May 14 06:37:30 tidal systemd[1]: Stopping Music Player Daemon... May 14 06:37:30 tidal ntpd[2215]: 95.85.21.89 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 51.159.236.138 local addr 192.168.178.23 -> May 14 06:37:30 tidal ntpd[2215]: 94.198.159.15 local addr 192.168.178.23 -> May 14 06:37:30 tidal bluetoothd[462]: Endpoint unregistered: sender=:1.44 path=/MediaEndpoint/A2DPSource May 14 06:37:30 tidal bluetoothd[462]: Endpoint unregistered: sender=:1.44 path=/MediaEndpoint/A2DPSink May 14 06:37:30 tidal systemd[1]: Stopping LSB: Brings up/down network automatically... May 14 06:37:30 tidal systemd[1]: Stopping volumio-remote-updater.service... May 14 06:37:30 tidal systemd[1]: volumio-remote-updater.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: volumio-remote-updater.service: Succeeded. May 14 06:37:30 tidal volumiobt[2233]: Killing BT Pair agent May 14 06:37:30 tidal systemd[1]: Stopped volumio-remote-updater.service. May 14 06:37:30 tidal systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: getty@tty1.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Getty on tty1. May 14 06:37:30 tidal systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: smbd.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Samba SMB Daemon. May 14 06:37:30 tidal systemd[1]: shairport-sync.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 14 06:37:30 tidal volumiobt[1663]: Terminated May 14 06:37:30 tidal systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: vtcs.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Volumio Tidal Connect Service. May 14 06:37:30 tidal systemd[1]: rtkit-daemon.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: rtkit-daemon.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped RealtimeKit Scheduling Policy Service. May 14 06:37:30 tidal systemd[1]: polkit.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: polkit.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Authorization Manager. May 14 06:37:30 tidal systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal systemd[1]: sshtunnel.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped MyVolumio SSH Tunnel. May 14 06:37:30 tidal systemd[1]: ntp.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Network Time Service. May 14 06:37:30 tidal systemd[1]: run-rpc_pipefs.mount: Succeeded. May 14 06:37:30 tidal systemd[1]: Unmounted RPC Pipe File System. May 14 06:37:30 tidal systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM May 14 06:37:30 tidal sudo[2246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 14 06:37:30 tidal sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 06:37:30 tidal sudo[2246]: pam_unix(sudo:session): session closed for user root May 14 06:37:30 tidal dhcpcd[422]: eth0: removing interface May 14 06:37:30 tidal systemd[1]: mpd.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Music Player Daemon. May 14 06:37:30 tidal systemd[1]: volumiobt.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Volumio Bluetooth Module. May 14 06:37:30 tidal dnsmasq[860]: exiting on receipt of SIGTERM May 14 06:37:30 tidal systemd[1]: dnsmasq.service: Succeeded. May 14 06:37:30 tidal volumio[824]: info: Shutting Down May 14 06:37:30 tidal systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. May 14 06:37:30 tidal bluetoothd[462]: Stopping SDP server May 14 06:37:30 tidal bluetoothd[462]: Exit May 14 06:37:30 tidal systemd[1]: bluetooth.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Bluetooth service. May 14 06:37:30 tidal systemd[1]: cpufrequtils.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped LSB: set CPUFreq kernel parameters. May 14 06:37:30 tidal systemd[1]: Stopping LSB: Load kernel modules needed to enable cpufreq scaling... May 14 06:37:30 tidal systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... May 14 06:37:30 tidal systemd[1]: Stopped target Sound Card. May 14 06:37:30 tidal systemd[1]: Stopping Save/Restore Sound Card State... May 14 06:37:30 tidal avahi-daemon[381]: Got SIGTERM, quitting. May 14 06:37:30 tidal avahi-daemon[381]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 14 06:37:30 tidal avahi-daemon[381]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.178.23. May 14 06:37:30 tidal ifplugd(eth0)[616]: Exiting. May 14 06:37:30 tidal systemd[1]: Stopping Avahi mDNS/DNS-SD Stack... May 14 06:37:30 tidal winbindd[970]: [2024/05/14 06:37:30.347565, 0] ../source3/winbindd/winbindd.c:244(winbindd_sig_term_handler) May 14 06:37:30 tidal winbindd[970]: Got sig[15] terminate (is_parent=1) May 14 06:37:30 tidal systemd[1]: Stopping Samba Winbind Daemon... May 14 06:37:30 tidal systemd[1]: Starting Show Plymouth Power Off Screen... May 14 06:37:30 tidal systemd[1]: Stopping Permit User Sessions... May 14 06:37:30 tidal systemd[1]: Removed slice system-getty.slice. May 14 06:37:30 tidal systemd[1]: rc-local.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped /etc/rc.local Compatibility. May 14 06:37:30 tidal systemd[1]: winbind.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Samba Winbind Daemon. May 14 06:37:30 tidal systemd[1]: alsa-restore.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Save/Restore Sound Card State. May 14 06:37:30 tidal systemd[1]: Stopping Manage Sound Card State (restore and store)... May 14 06:37:30 tidal avahi-daemon[381]: avahi-daemon 0.7 exiting. May 14 06:37:30 tidal systemd[1]: Stopping Samba NMB Daemon... May 14 06:37:30 tidal nmbd[603]: [2024/05/14 06:37:30.367709, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 14 06:37:30 tidal systemd[1]: systemd-user-sessions.service: Succeeded. May 14 06:37:30 tidal nmbd[603]: started asyncdns process 2272 May 14 06:37:30 tidal systemd[1]: Stopped Permit User Sessions. May 14 06:37:30 tidal systemd[1]: Received SIGRTMIN+20 from PID 2270 (plymouthd). May 14 06:37:30 tidal systemd[1]: avahi-daemon.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Avahi mDNS/DNS-SD Stack. May 14 06:37:30 tidal alsactl[391]: alsactl daemon stopped May 14 06:37:30 tidal systemd[1]: alsa-state.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Manage Sound Card State (restore and store). May 14 06:37:30 tidal systemd[1]: dhcpcd.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped DHCP Client Daemon. May 14 06:37:30 tidal volumio[824]: error: Upnp client error: Error: This socket has been ended by the other party May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal volumio[824]: ------------------------------------ BT MESSAGE: BT STATUS: running May 14 06:37:30 tidal systemd[1]: systemd-logind.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Login Service. May 14 06:37:30 tidal kernel: iwlwifi 0000:02:00.0: Radio type=0x2-0x1-0x0 May 14 06:37:30 tidal volumio[824]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 06:37:30 tidal volumio[824]: Error: dns service error: unknown May 14 06:37:30 tidal volumio[824]: at Browser.on_service_changed (/volumio/node_modules/mdns/lib/browser.js:84:33) May 14 06:37:30 tidal volumio[824]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 14 06:37:30 tidal volumio[824]: errorCode: -65537 May 14 06:37:30 tidal volumio[824]: } May 14 06:37:30 tidal volumio[824]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 06:37:30 tidal systemd[1]: triggerhappy.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped triggerhappy global hotkey daemon. May 14 06:37:30 tidal ifplugd[2238]: Network Interface Plugging Daemon...stop eth0...done. May 14 06:37:30 tidal systemd[1]: ifplugd.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped LSB: Brings up/down network automatically. May 14 06:37:30 tidal systemd[1]: Started Show Plymouth Power Off Screen. May 14 06:37:30 tidal systemd[1]: loadcpufreq.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped LSB: Load kernel modules needed to enable cpufreq scaling. May 14 06:37:30 tidal systemd[1]: Stopped target Remote File Systems. May 14 06:37:30 tidal systemd[1]: Stopped target Remote File Systems (Pre). May 14 06:37:30 tidal systemd[1]: Stopped target NFS client services. May 14 06:37:30 tidal startx[826]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. May 14 06:37:30 tidal kernel: iwlwifi 0000:02:00.0: Radio type=0x2-0x1-0x0 May 14 06:37:30 tidal systemd[1]: hostapd.service: Succeeded. May 14 06:37:30 tidal systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. May 14 06:37:30 tidal sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-14 06:36 May 14 06:37:30 tidal sudo[2289]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 09:11:44 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="cc217ff307fce46c151e847456bc4d4d"