-- Logs begin at Thu 2019-02-14 10:12:00 GMT, end at Tue 2024-07-23 14:25:14 BST. -- Jul 23 14:24:01 volumiou volumio[1050]: info: MRS: Found cast device: Google-Nest-Mini-86f00b066aefe55de00646f6eabfa60b Jul 23 14:24:01 volumiou volumio[1050]: info: MRS: Found cast device: Google-Nest-Mini-86f00b066aefe55de00646f6eabfa60b Jul 23 14:24:14 volumiou volumio[1050]: info: Jul 23 14:24:14 volumiou volumio[1050]: ---------------------------- MPD announces system playlist update Jul 23 14:24:14 volumiou volumio[1050]: info: Ignoring MPD Status Update Jul 23 14:24:14 volumiou volumio[1050]: info: Jul 23 14:24:14 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:24:14 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:24:14 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:24:14 volumiou volumio[1050]: info: ------------------------------ 2ms Jul 23 14:24:14 volumiou volumio[1050]: info: sendMpdCommand status took 2 milliseconds Jul 23 14:24:14 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:24:14 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:24:14 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 23 14:24:14 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:24:14 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:24:14 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:24:14 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:14 volumiou volumio[1050]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31022981,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Peace Of Mind - Boston","artist":"Planet Rock","album":null,"uri":"http://edge-bauerall-01-gos2.sharp-stream.com/planetrock.mp3?aw_0_1st.skey=1652375517","trackType":""} Jul 23 14:24:14 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:24:14 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService play Jul 23 14:24:14 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus play Jul 23 14:24:14 volumiou volumio[1050]: info: Received an update from plugin. extracting info from payload Jul 23 14:24:14 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 23 14:24:14 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:14 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:24:14 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:14 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:14 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:14 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:14 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:14 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:14 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:14 volumiou volumio[1050]: info: ------------------------------ 20ms Jul 23 14:24:15 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:19 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:19 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:29 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Jul 23 14:24:37 volumiou volumio[1050]: error: Failed request for metavolumio API Jul 23 14:24:37 volumiou volumio[1050]: error: Supersearch failed for query: {"value":"darksynth with vocals","instantPlay":false,"socketId":"Tv-XXgXQA4Y76srWAAAN"} with error: No tracks returned from supersearch Jul 23 14:24:42 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:24:43 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:43 volumiou volumio[1050]: info: searchTIDALUri took 406 milliseconds Jul 23 14:24:43 volumiou volumio[1050]: info: search took 406 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 459 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 460 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 270 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 270 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 376 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 377 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 345 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 345 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 471 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 472 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: searchTIDALUri took 486 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: search took 487 milliseconds Jul 23 14:24:44 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:44 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:46 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:24:54 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:24:54 volumiou volumio[1050]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::ClearQueue Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::stop Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::stPlaybackTimer Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:54 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:24:54 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:54 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:54 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::serviceStop Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:54 volumiou volumio[1050]: info: CoreCommandRouter::serviceStop Jul 23 14:24:54 volumiou volumio[1050]: info: [1721741094844] ControllerWebradio::stop Jul 23 14:24:54 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand stop Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::clearPlayQueue Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:24:54 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:24:54 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:24:54 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:24:54 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045458 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/19045458 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045462 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/19045462 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/22769541 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/22769541 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/14511889 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/14511889 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/22881762 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/22881762 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045454 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/19045454 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/1570711 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/1570711 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/80182532 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/80182532 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/41877240 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/41877240 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/137059373 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/137059373 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/63311050 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/63311050 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/3108153 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/3108153 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/106558862 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/106558862 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/85127648 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/85127648 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/13941548 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/13941548 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/67261060 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/67261060 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/15815997 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/15815997 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/356964721 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/356964721 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/20115568 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/20115568 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/3894615 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/3894615 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/41877235 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/41877235 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/85127650 Jul 23 14:24:54 volumiou volumio[1050]: info: Exploding uri tidal://song/85127650 in service tidal Jul 23 14:24:54 volumiou volumio[1050]: info: Jul 23 14:24:54 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:24:54 volumiou volumio[1050]: info: sendMpdCommand stop took 116 milliseconds Jul 23 14:24:54 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:24:54 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand status took 51 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:24:55 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: 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":"Peace Of Mind - Boston","artist":"Planet Rock","album":null,"uri":"http://edge-bauerall-01-gos2.sharp-stream.com/planetrock.mp3?aw_0_1st.skey=1652375517","trackType":""} Jul 23 14:24:55 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService stop Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus stop Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:55 volumiou volumio[1050]: info: No code Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:55 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:55 volumiou volumio[1050]: info: ------------------------------ 108ms Jul 23 14:24:55 volumiou volumio[1050]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 572 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 564 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 569 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 643 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 669 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 684 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 728 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 723 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 742 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 757 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 816 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 821 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 842 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 856 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 904 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 947 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 945 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 966 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 983 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 993 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 1032 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: explodeTIDALUri took 1079 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:24:55 volumiou volumio[1050]: info: CoreCommandRouter::volumioPlay Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::play index 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::stop Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::play index undefined Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::startPlaybackTimer Jul 23 14:24:55 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:55 volumiou volumio[1050]: info: [1721741095967] ControllerTidal::clearAddPlayTrack Jul 23 14:24:55 volumiou volumio[1050]: info: Getting stream with soundQuality LOSSLESS Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand stop Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand stop took 2 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand clear Jul 23 14:24:55 volumiou volumio[1050]: info: Jul 23 14:24:55 volumiou volumio[1050]: ---------------------------- MPD announces system playlist update Jul 23 14:24:55 volumiou volumio[1050]: info: Ignoring MPD Status Update Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand clear took 5 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/19045458&soundQuality=LOSSLESS" Jul 23 14:24:55 volumiou volumio[1050]: error: updateQueue error: null Jul 23 14:24:55 volumiou volumio[1050]: info: Jul 23 14:24:55 volumiou volumio[1050]: ---------------------------- MPD announces system playlist update Jul 23 14:24:55 volumiou volumio[1050]: info: Ignoring MPD Status Update Jul 23 14:24:55 volumiou volumio[1050]: info: ------------------------------ 3ms Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/19045458&soundQuality=LOSSLESS" took 3 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 23 14:24:55 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand play Jul 23 14:24:55 volumiou volumio[1050]: info: ------------------------------ 4ms Jul 23 14:24:55 volumiou volumio[1050]: info: sendMpdCommand play took 3 milliseconds Jul 23 14:24:55 volumiou volumio[1050]: STREAMING PROXY: Handling url /?data=tidal://song/19045458&soundQuality=LOSSLESS Jul 23 14:24:56 volumiou volumio[1050]: info: Executing endpoint getStreamUrltidal Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Jul 23 14:24:56 volumiou volumio[1050]: info: getStreamUrl took 503 milliseconds Jul 23 14:24:56 volumiou volumio[1050]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidlYzIxMjg4YjlhMDg3YTcyYjYxMWE2YTQxYWVhOGQ3Nl82MS5tcDQ/0.flac?Expires=1721744696&Signature=eOoXRvfn7~fIAimGzqFtisbSMWf5gva7wKJwlgKsk4VIHeyEqBkth5SZhsguIoPn4a7NQs7EHoTXS-m6qr6cE7DOJxOoIPuyHxuGM22EabzYJlQtag2wjbgxHD-y2QxloY2pWtZXO7tmMV28hE8vZLr2rQZUMdhpRFBgRWMaWhkxFVHrvAwQz59Pak3xBsdpM0kNMykizqKO1NIHNhduP79p1EL-s6ZO1-PypuGBa4l9VIUiOy8sVN~LYH1OvUOuM9ic4uQBHUHy-kpA0lfmO6~8Lb~8b1JM2z-x7hrmxufGdQ7MsY6DmucRyfhgBWiT8jr0f4PC~Kw8dXjyS5kGbQ__&Key-Pair-Id=K14LZCZ9QUI4JL Jul 23 14:24:56 volumiou volumio[1050]: STREAMING PROXY: Response: 200, length: 32563723 Jul 23 14:24:56 volumiou volumio[1050]: info: Jul 23 14:24:56 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:24:56 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:24:56 volumiou volumio[1050]: info: Jul 23 14:24:56 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:24:56 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:24:56 volumiou volumio[1050]: info: sendMpdCommand status took 2 milliseconds Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:24:56 volumiou volumio[1050]: info: sendMpdCommand status took 2 milliseconds Jul 23 14:24:56 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:24:56 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:24:56 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:56 volumiou volumio[1050]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19045458&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/19045458&soundQuality=LOSSLESS","trackType":"tidal"} Jul 23 14:24:56 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService play Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus stop Jul 23 14:24:56 volumiou volumio[1050]: info: ------------------------------ 10ms Jul 23 14:24:56 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 23 14:24:56 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:24:56 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:24:56 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:24:56 volumiou volumio[1050]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19045458&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/19045458&soundQuality=LOSSLESS","trackType":"tidal"} Jul 23 14:24:56 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService play Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus play Jul 23 14:24:56 volumiou volumio[1050]: info: Received an update from plugin. extracting info from payload Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:56 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:56 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:56 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:24:56 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:24:56 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:24:56 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:24:56 volumiou volumio[1050]: info: ------------------------------ 32ms Jul 23 14:24:56 volumiou volumio[1050]: info: [LastFM] Current track has sufficient metadata: title (Nightcall) and artist (Kavinsky) passed on explicitly Jul 23 14:24:56 volumiou volumio[1050]: info: touch_display: Setting screensaver timeout to 0 seconds. Jul 23 14:24:57 volumiou volumio[1050]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Nightcall","mbid":"071f35d6-e583-4efd-9270-e4ee2179850e","url":"https://www.last.fm/music/Kavinsky/_/Nightcall","duration":"258000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"901359","playcount":"9612596","artist":{"name":"Kavinsky","mbid":"eb6de5f6-98f8-4b5a-bfdc-f87fa4936baa","url":"https://www.last.fm/music/Kavinsky"},"album":{"@":{"position":"1"},"artist":"Kavinsky","title":"Nightcall","mbid":"851588f7-9cdb-473f-96d0-21680c4a383c","url":"https://www.last.fm/music/Kavinsky/Nightcall","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/f3fab67e391548f68e5118882db6b031.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/f3fab67e391548f68e5118882db6b031.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/f3fab67e391548f68e5118882db6b031.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/f3fab67e391548f68e5118882db6b031.png","@":{"size":"extralarge"}}]},"userplaycount":"2","userloved":"0","toptags":{"tag":[{"name":"electronic","url":"https://www.last.fm/tag/electronic"},{"name":"chill","url":"https://www.last.fm/tag/chill"},{"name":"electro","url":"https://www.last.fm/tag/electro"},{"name":"sexy","url":"https://www.last.fm/tag/sexy"},{"name":"drive","url":"https://www.last.fm/tag/drive"}]},"wiki":{"published":"31 Jan 2012, 03:16","summary":"Produced by Guy Manuel de Homem-Christo (one half of Daft Punk). Featured in the 2011 film Drive Read more on Last.fm.","content":"Produced by Guy Manuel de Homem-Christo (one half of Daft Punk). Featured in the 2011 film Drive Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} Jul 23 14:24:57 volumiou volumio[1050]: STREAMING PROXY: Client dropped request, destroying Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::ClearQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::stop Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::stPlaybackTimer Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:25:08 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:25:08 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::serviceStop Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::serviceStop Jul 23 14:25:08 volumiou volumio[1050]: info: [1721741108279] ControllerTidal::stop Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 23 14:25:08 volumiou volumio[1050]: info: ControllerMpd::stop Jul 23 14:25:08 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand stop Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::clearPlayQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/14511889 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/14511889 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPlay Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::play index 0 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::stop Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::play index undefined Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::startPlaybackTimer Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioGetVisibleSources Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 23 14:25:08 volumiou volumio[1050]: info: [1721741108305] ControllerTidal::clearAddPlayTrack Jul 23 14:25:08 volumiou volumio[1050]: info: Getting stream with soundQuality LOSSLESS Jul 23 14:25:08 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand stop Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045454 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/19045454 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045462 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/19045462 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:25:08 volumiou volumio[1050]: info: sendMpdCommand stop took 126 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/22769541 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/22769541 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/19045458 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/19045458 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/1570711 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/1570711 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/22881762 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/22881762 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/41877240 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/41877240 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/3894615 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/3894615 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/80182532 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/80182532 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/137059373 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/137059373 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/356964721 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/356964721 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/63311050 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/63311050 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/106558862 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/106558862 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/67261060 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/67261060 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/85127650 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/85127650 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/15815997 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/15815997 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/85127648 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/85127648 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/13941548 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/13941548 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: searchTIDALUri took 190 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: search took 191 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:08 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:08 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/3108153 Jul 23 14:25:08 volumiou volumio[1050]: info: Using cached record of: tidal://song/3108153 Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:08 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:08 volumiou volumio[1050]: info: All cached search sources collected Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 23 14:25:08 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jul 23 14:25:08 volumiou volumio[1050]: info: searchTIDALUri took 200 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: search took 200 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: Jul 23 14:25:08 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:25:08 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:25:08 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:25:08 volumiou volumio[1050]: info: sendMpdCommand stop took 479 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand clear Jul 23 14:25:08 volumiou volumio[1050]: info: searchTIDALUri took 137 milliseconds Jul 23 14:25:08 volumiou volumio[1050]: info: search took 137 milliseconds Jul 23 14:25:09 volumiou volumio[1050]: info: searchTIDALUri took 728 milliseconds Jul 23 14:25:09 volumiou volumio[1050]: info: search took 729 milliseconds Jul 23 14:25:09 volumiou volumio[1050]: info: searchTIDALUri took 838 milliseconds Jul 23 14:25:09 volumiou volumio[1050]: info: search took 839 milliseconds Jul 23 14:25:09 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:25:09 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:10 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:25:10 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:25:10 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:25:10 volumiou volumio[1050]: info: All search sources collected, pushing search results Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:10 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/41877235 Jul 23 14:25:10 volumiou volumio[1050]: info: Using cached record of: tidal://song/41877235 Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::volumioAddQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: CoreStateMachine::addQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::addQueueItems Jul 23 14:25:10 volumiou volumio[1050]: info: Preload queue cleared Jul 23 14:25:10 volumiou volumio[1050]: info: Adding Item to queue: tidal://song/20115568 Jul 23 14:25:10 volumiou volumio[1050]: info: Using cached record of: tidal://song/20115568 Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::emitMessageToSpecificClient pushBrowseLibrary Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushQueue Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::saveQueue Jul 23 14:25:10 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:10 volumiou volumio[1050]: info: CoreStateMachine::updateTrackBlock Jul 23 14:25:10 volumiou volumio[1050]: info: CorePlayQueue::getTrackBlock Jul 23 14:25:10 volumiou volumio[1050]: info: Jul 23 14:25:10 volumiou volumio[1050]: ---------------------------- MPD announces system playlist update Jul 23 14:25:10 volumiou volumio[1050]: info: Ignoring MPD Status Update Jul 23 14:25:10 volumiou volumio[1050]: info: sendMpdCommand status took 1625 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: info: sendMpdCommand clear took 1624 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:25:10 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:25:10 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/14511889&soundQuality=LOSSLESS" Jul 23 14:25:10 volumiou volumio[1050]: error: updateQueue error: null Jul 23 14:25:10 volumiou volumio[1050]: info: Jul 23 14:25:10 volumiou volumio[1050]: ---------------------------- MPD announces system playlist update Jul 23 14:25:10 volumiou volumio[1050]: info: Ignoring MPD Status Update Jul 23 14:25:10 volumiou volumio[1050]: info: ------------------------------ 3ms Jul 23 14:25:10 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/14511889&soundQuality=LOSSLESS" took 3 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:25:10 volumiou volumio[1050]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 23 14:25:10 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand play Jul 23 14:25:10 volumiou volumio[1050]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 23 14:25:10 volumiou volumio[1050]: info: ------------------------------ 1630ms Jul 23 14:25:10 volumiou volumio[1050]: STREAMING PROXY: Handling url /?data=tidal://song/14511889&soundQuality=LOSSLESS Jul 23 14:25:10 volumiou volumio[1050]: info: ------------------------------ 11ms Jul 23 14:25:10 volumiou volumio[1050]: info: sendMpdCommand play took 9 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: info: Executing endpoint getStreamUrltidal Jul 23 14:25:10 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Jul 23 14:25:10 volumiou volumio[1050]: info: getStreamUrl took 507 milliseconds Jul 23 14:25:10 volumiou volumio[1050]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidhNWJjYzM1ODcxZDUyZTZkZWFmMGQyZTQ1MmEwNzU1NV82MS5tcDQ/0.flac?Expires=1721744710&Signature=LX0tp48ud2rYLRxr4QgCmi4iEnCJDtxCORkjEJdwKEl2gfDPE~VLdBriXy0bHKzFol2ARsswNREdhQLqg37O-631-feZe5PKy2xjsdFB7gV-qIMdNF-eEXJ8PgU6QCtsl8lLXuHwZJVn60i1GYjqNfXkvyoCPqASnvzc~NhfjJY2RWfSQUPgrHRHO844Q02A5v9NUjN7EAqm3s5DSM1qVdnOEegCwP-HtsLT7~cIF0mSwQ0g8VqA8WePMzMCnBwskqd0wJveU8mNUaEfjedKkFlILCyDPS3cx6C0LX-r-Y8mxQ8EsBx4qJ9H2bOZn1lMxuGJNpKEdWQ-uWuVgCcPXQ__&Key-Pair-Id=K14LZCZ9QUI4JL Jul 23 14:25:11 volumiou volumio[1050]: STREAMING PROXY: Response: 200, length: 43085070 Jul 23 14:25:11 volumiou volumio[1050]: info: Jul 23 14:25:11 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:25:11 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:25:11 volumiou volumio[1050]: info: Jul 23 14:25:11 volumiou volumio[1050]: ---------------------------- MPD announces state update: player Jul 23 14:25:11 volumiou volumio[1050]: info: sendMpdCommand status took 3 milliseconds Jul 23 14:25:11 volumiou volumio[1050]: info: ControllerMpd::getState Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand status Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:25:11 volumiou volumio[1050]: info: sendMpdCommand status took 1 milliseconds Jul 23 14:25:11 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::parseState Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:25:11 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:25:11 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:25:11 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:11 volumiou volumio[1050]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":343,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14511889&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/14511889&soundQuality=LOSSLESS","trackType":"tidal"} Jul 23 14:25:11 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService play Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus stop Jul 23 14:25:11 volumiou volumio[1050]: info: ------------------------------ 8ms Jul 23 14:25:11 volumiou volumio[1050]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 23 14:25:11 volumiou volumio[1050]: verbose: ControllerMpd::parseTrackInfo Jul 23 14:25:11 volumiou volumio[1050]: info: ControllerMpd::pushState Jul 23 14:25:11 volumiou volumio[1050]: info: CoreCommandRouter::servicePushState Jul 23 14:25:11 volumiou volumio[1050]: info: CorePlayQueue::getTrack 0 Jul 23 14:25:11 volumiou volumio[1050]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":343,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"14511889&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/14511889&soundQuality=LOSSLESS","trackType":"tidal"} Jul 23 14:25:11 volumiou volumio[1050]: verbose: CURRENT POSITION 0 Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::syncState stateService play Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::syncState currentStatus play Jul 23 14:25:11 volumiou volumio[1050]: info: Received an update from plugin. extracting info from payload Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:25:11 volumiou volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 23 14:25:11 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:25:11 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:25:11 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:25:11 volumiou volumio[1050]: info: CoreStateMachine::pushState Jul 23 14:25:11 volumiou volumio[1050]: info: CoreCommandRouter::volumioPushState Jul 23 14:25:11 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output update for this device Jul 23 14:25:11 volumiou volumio[1050]: info: MRS: Pushing multiroomSync output Jul 23 14:25:11 volumiou volumio[1050]: info: ------------------------------ 18ms Jul 23 14:25:11 volumiou volumio[1050]: info: [LastFM] Current track has sufficient metadata: title (The drone) and artist (College) passed on explicitly Jul 23 14:25:11 volumiou volumio[1050]: info: touch_display: Setting screensaver timeout to 0 seconds. Jul 23 14:25:13 volumiou volumio[1050]: STREAMING PROXY: Client dropped request, destroying Jul 23 14:25:14 volumiou volumio[1050]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 23 14:25:14 volumiou volumio[1050]: TypeError: Cannot read property '@' of null Jul 23 14:25:14 volumiou volumio[1050]: at Object.callback (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:342:14) Jul 23 14:25:14 volumiou volumio[1050]: at /data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:60:13 Jul 23 14:25:14 volumiou volumio[1050]: at Parser. (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:304:18) Jul 23 14:25:14 volumiou volumio[1050]: at Parser.emit (events.js:315:20) Jul 23 14:25:14 volumiou volumio[1050]: at Parser.exports.Parser.Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:314:16) Jul 23 14:25:14 volumiou volumio[1050]: at Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:5:59) Jul 23 14:25:14 volumiou volumio[1050]: at IncomingMessage. (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:58:14) Jul 23 14:25:14 volumiou volumio[1050]: at IncomingMessage.emit (events.js:327:22) Jul 23 14:25:14 volumiou volumio[1050]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 23 14:25:14 volumiou volumio[1050]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 23 14:25:14 volumiou volumio[1050]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 23 14:25:14 volumiou sudo[30497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-23 14:24 Jul 23 14:25:14 volumiou sudo[30497]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"