-- Logs begin at Mon 2024-09-02 11:49:23 CEST, end at Tue 2024-09-03 14:49:32 CEST. -- Sep 03 14:48:00 bladelius volumio[834]: info: explodeTIDALUri took 647 milliseconds Sep 03 14:48:00 bladelius volumio[834]: error: Commandrouter: Cannot explode uri tidal://song/53124475 from service tidal: Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::volumioPushQueue Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::saveQueue Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::updateTrackBlock Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrackBlock Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::volumioPlay Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::play index 1 Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::stop Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::play index undefined Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::startPlaybackTimer Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: [1725367680143] ControllerTidal::clearAddPlayTrack Sep 03 14:48:00 bladelius volumio[834]: info: Getting stream with soundQuality LOSSLESS Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand stop took 13 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:00 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:00 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand status took 5 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand clear took 5 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand status took 4 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand status took 3 milliseconds Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/38648620&soundQuality=LOSSLESS" Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:00 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:00 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:00 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Sep 03 14:48:00 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:00 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:00 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:00 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:00 bladelius volumio[834]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 20ms Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 20ms Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: error: updateQueue error: null Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 23ms Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/38648620&soundQuality=LOSSLESS" took 20 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 5ms Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 4ms Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::parseTrackInfo Sep 03 14:48:00 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 03 14:48:00 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand play Sep 03 14:48:00 bladelius volumio[834]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 30ms Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: info: Sep 03 14:48:00 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:00 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:00 bladelius volumio[834]: STREAMING PROXY: Handling url /?data=tidal://song/38648620&soundQuality=LOSSLESS Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 13ms Sep 03 14:48:00 bladelius volumio[834]: info: sendMpdCommand play took 11 milliseconds Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 9ms Sep 03 14:48:00 bladelius volumio[834]: info: ------------------------------ 8ms Sep 03 14:48:00 bladelius volumio[834]: info: No valid Plugin REST Endpoint: getStreamUrltidal Sep 03 14:48:00 bladelius volumio[834]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl Sep 03 14:48:04 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::ClearQueue Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::clearPlayQueue Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::saveQueue Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushQueue Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::addQueueItems Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::addQueueItems Sep 03 14:48:04 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/33091248 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/33091248 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/38648620 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/38648620 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/684866 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/684866 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/145932440 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/145932440 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/82811590 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/82811590 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/8439076 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/8439076 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/23233335 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/23233335 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/137579936 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/137579936 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/29686030 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/29686030 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/25029974 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/25029974 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/84359033 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/84359033 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/17819619 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/17819619 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1289978 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1289978 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/553 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/553 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/192576387 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/192576387 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/192576389 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/192576389 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/71102676 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/71102676 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/36267253 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/36267253 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/25029826 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/25029826 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/25029818 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/25029818 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/2565550 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/2565550 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/53124475 Sep 03 14:48:04 bladelius volumio[834]: info: Exploding uri tidal://song/53124475 in service tidal Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/64629992 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/64629992 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/40617399 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/40617399 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/25558097 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/25558097 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/63493 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/63493 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/17433741 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/17433741 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/77168302 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/77168302 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/8621982 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/8621982 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/245846051 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/245846051 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1355852 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1355852 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/17342661 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/17342661 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/12976089 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/12976089 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/300767982 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/300767982 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/8755973 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/8755973 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/80451006 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/80451006 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/15026231 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/15026231 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/80666461 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/80666461 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/3131405 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/3131405 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/169956705 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/169956705 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/109597132 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/109597132 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/64629993 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/64629993 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/30498862 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/30498862 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/138268048 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/138268048 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/5761228 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/5761228 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/86301053 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/86301053 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/86301055 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/86301055 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1852096 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1852096 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/3121723 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/3121723 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/3343903 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/3343903 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/40617348 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/40617348 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/268019983 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/268019983 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/65749639 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/65749639 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/17010344 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/17010344 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/285378484 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/285378484 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68968212 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68968212 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1486040 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1486040 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/105489740 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/105489740 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/35986106 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/35986106 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/307586980 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/307586980 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/5261765 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/5261765 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/76271198 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/76271198 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/6728986 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/6728986 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/6728987 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/6728987 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68957186 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68957186 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1212956 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1212956 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/49160035 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/49160035 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/12359468 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/12359468 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/82218196 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/82218196 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/22955032 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/22955032 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/19442765 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/19442765 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/117059393 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/117059393 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/208381546 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/208381546 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/3469785 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/3469785 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/94371582 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/94371582 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/77620096 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/77620096 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/52159027 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/52159027 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/110958685 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/110958685 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/85134401 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/85134401 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/198776168 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/198776168 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/185466585 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/185466585 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/71197129 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/71197129 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/73372441 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/73372441 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/13160904 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/13160904 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/65233561 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/65233561 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/622357 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/622357 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/37668298 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/37668298 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/37668275 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/37668275 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1863967 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1863967 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1864051 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1864051 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1864054 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1864054 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1864063 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1864063 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/1864057 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/1864057 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/167884779 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/167884779 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/167884781 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/167884781 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/182434609 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/182434609 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/182434610 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/182434610 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/179652037 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/179652037 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/331976491 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/331976491 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/232915717 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/232915717 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/344477581 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/344477581 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/344504078 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/344504078 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68493658 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68493658 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68493629 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68493629 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68493640 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68493640 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/68493905 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/68493905 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/88470650 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/88470650 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/341570391 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/341570391 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/184588449 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/184588449 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/117840726 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/117840726 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/138268033 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/138268033 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/158796999 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/158796999 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/295885744 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/295885744 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/88522994 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/88522994 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/121288693 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/121288693 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/354787666 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/354787666 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/354787668 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/354787668 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/354787656 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/354787656 Sep 03 14:48:04 bladelius volumio[834]: info: Adding Item to queue: tidal://song/4082031 Sep 03 14:48:04 bladelius volumio[834]: info: Using cached record of: tidal://song/4082031 Sep 03 14:48:04 bladelius volumio[834]: info: explodeTIDALUri took 677 milliseconds Sep 03 14:48:04 bladelius volumio[834]: error: Commandrouter: Cannot explode uri tidal://song/53124475 from service tidal: Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushQueue Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::saveQueue Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::updateTrackBlock Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::getTrackBlock Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPlay Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::play index 1 Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::play index undefined Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::startPlaybackTimer Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:04 bladelius volumio[834]: info: [1725367684738] ControllerTidal::clearAddPlayTrack Sep 03 14:48:04 bladelius volumio[834]: info: Getting stream with soundQuality LOSSLESS Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand stop took 4 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:04 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand status took 4 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand clear took 4 milliseconds Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/38648620&soundQuality=LOSSLESS" Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:04 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:04 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:04 bladelius volumio[834]: error: updateQueue error: null Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:04 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 13ms Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/38648620&soundQuality=LOSSLESS" took 10 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand status took 7 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand status took 5 milliseconds Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::parseTrackInfo Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand play Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:04 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:04 bladelius volumio[834]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 03 14:48:04 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 14:48:04 bladelius volumio[834]: STREAMING PROXY: Handling url /?data=tidal://song/38648620&soundQuality=LOSSLESS Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:04 bladelius volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 03 14:48:04 bladelius volumio[834]: verbose: CURRENT POSITION 1 Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::syncState stateService stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::syncState currentStatus stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: No code Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: CorePlayQueue::getTrack 1 Sep 03 14:48:04 bladelius volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 03 14:48:04 bladelius volumio[834]: verbose: CURRENT POSITION 1 Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::syncState stateService stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::syncState currentStatus stop Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: No code Sep 03 14:48:04 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:04 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:04 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 56ms Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 52ms Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 51ms Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:04 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:04 bladelius volumio[834]: info: Sep 03 14:48:04 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:04 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 57ms Sep 03 14:48:04 bladelius volumio[834]: info: sendMpdCommand play took 52 milliseconds Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 10ms Sep 03 14:48:04 bladelius volumio[834]: info: ------------------------------ 9ms Sep 03 14:48:04 bladelius volumio[834]: info: No valid Plugin REST Endpoint: getStreamUrltidal Sep 03 14:48:04 bladelius volumio[834]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl Sep 03 14:48:05 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:06 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:07 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:08 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:09 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:10 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:11 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:12 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:13 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:14 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:15 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:16 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:17 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:18 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:19 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:20 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:21 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:22 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:23 bladelius volumio[834]: Searching all installed plugins Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: , search Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 03 14:48:23 bladelius volumio[834]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 03 14:48:23 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: tidal , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:24 bladelius volumio[834]: Searching all installed plugins Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 03 14:48:24 bladelius volumio[834]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 03 14:48:24 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: tidal , search Sep 03 14:48:25 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:25 bladelius volumio[834]: info: searchTIDALUri took 1905 milliseconds Sep 03 14:48:25 bladelius volumio[834]: info: search took 1906 milliseconds Sep 03 14:48:26 bladelius volumio[834]: info: searchQOBUZUri took 2435 milliseconds Sep 03 14:48:26 bladelius volumio[834]: info: All search sources collected, pushing search results Sep 03 14:48:26 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:26 bladelius volumio[834]: info: searchTIDALUri took 2113 milliseconds Sep 03 14:48:26 bladelius volumio[834]: info: search took 2114 milliseconds Sep 03 14:48:26 bladelius volumio[834]: info: searchQOBUZUri took 2233 milliseconds Sep 03 14:48:26 bladelius volumio[834]: info: All search sources collected, pushing search results Sep 03 14:48:27 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:28 bladelius volumio[834]: Searching all installed plugins Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: , search Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , search Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Sep 03 14:48:28 bladelius volumio[834]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: webradio , search Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Sep 03 14:48:28 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: tidal , search Sep 03 14:48:29 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:30 bladelius volumio[834]: info: searchQOBUZUri took 1218 milliseconds Sep 03 14:48:30 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:30 bladelius volumio[834]: info: searchTIDALUri took 1951 milliseconds Sep 03 14:48:30 bladelius volumio[834]: info: search took 1951 milliseconds Sep 03 14:48:30 bladelius volumio[834]: info: All search sources collected, pushing search results Sep 03 14:48:31 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:32 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:33 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:34 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:35 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:36 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:37 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:38 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:39 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:40 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:41 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Sep 03 14:48:41 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:42 bladelius volumio[834]: info: browseTIDALUri took 949 milliseconds Sep 03 14:48:42 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:42 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230852 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625218 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625220 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/6076597 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/171918042 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/6077223 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625219 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230860 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/89569622 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230855 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/146539264 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/293800778 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/6077222 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8755962 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8755961 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/89569620 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/293800779 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625221 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8745565 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625222 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230848 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/15155494 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8745563 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/6077227 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8755963 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625226 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/293800780 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625228 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/293800781 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/89569621 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8755964 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/146539265 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8745558 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/171918041 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625223 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230849 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625227 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625224 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9625225 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/89569626 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9440147 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/293800782 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/1381859 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8230853 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/89569624 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/6077224 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/171918038 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/9440148 Sep 03 14:48:42 bladelius volumio[834]: info: Preloading song: tidal://song/8755966 Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/8230852 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/9625218 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/9625220 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/6076597 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/171918042 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/6077223 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/9625219 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/8230860 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: explodeTIDALUri took 268 milliseconds Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/89569622 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/8230855 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/146539264 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/293800778 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: explodeTIDALUri took 226 milliseconds Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/6077222 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/8755962 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: explodeTIDALUri took 678 milliseconds Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/8755961 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: explodeTIDALUri took 696 milliseconds Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/89569620 in service tidal Sep 03 14:48:42 bladelius volumio[834]: info: Exploding uri tidal://song/293800779 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625221 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 695 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8745565 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 675 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 650 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 791 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625222 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8230848 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 244 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 650 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:43 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:43 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:43 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:43 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:43 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/15155494 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 635 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8745563 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/6077227 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 666 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 646 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 243 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8755963 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 224 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625226 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 675 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 215 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/293800780 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 672 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625228 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 654 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/293800781 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 661 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/89569621 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 643 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8755964 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 634 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/146539265 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8745558 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/171918041 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625223 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/8230849 in service tidal Sep 03 14:48:43 bladelius volumio[834]: info: explodeTIDALUri took 641 milliseconds Sep 03 14:48:43 bladelius volumio[834]: info: Exploding uri tidal://song/9625227 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 644 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/9625224 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 776 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/9625225 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 694 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/89569626 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/9440147 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 683 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 640 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/293800782 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 764 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 642 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/1381859 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 639 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/8230853 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/89569624 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 654 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 648 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/6077224 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/171918038 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 656 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 639 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/9440148 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 648 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: Exploding uri tidal://song/8755966 in service tidal Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 657 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 643 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 636 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 635 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 646 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 720 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 657 milliseconds Sep 03 14:48:44 bladelius volumio[834]: info: explodeTIDALUri took 633 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: explodeTIDALUri took 656 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: explodeTIDALUri took 656 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: explodeTIDALUri took 652 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: explodeTIDALUri took 649 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: explodeTIDALUri took 646 milliseconds Sep 03 14:48:45 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:46 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:46 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:46 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:47 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:48 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:49 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:50 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:51 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:52 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:53 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Sep 03 14:48:53 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:54 bladelius volumio[834]: info: browseTIDALUri took 715 milliseconds Sep 03 14:48:54 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:54 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:54 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:54 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:54 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:54 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:54 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:54 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:54 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:54 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:55 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:56 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::ClearQueue Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::stop Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::clearPlayQueue Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::saveQueue Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioPushQueue Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::addQueueItems Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::addQueueItems Sep 03 14:48:56 bladelius volumio[834]: info: Preload queue cleared Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625218 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625218 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625219 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625219 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625220 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625220 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625221 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625221 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625222 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625222 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625223 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625223 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625224 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625224 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625225 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625225 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625226 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625226 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625227 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625227 Sep 03 14:48:56 bladelius volumio[834]: info: Adding Item to queue: tidal://song/9625228 Sep 03 14:48:56 bladelius volumio[834]: info: Using cached record of: tidal://song/9625228 Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioPushQueue Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::saveQueue Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::updateTrackBlock Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrackBlock Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioPlay Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::play index 0 Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::stop Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::play index undefined Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::startPlaybackTimer Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: [1725367736491] ControllerTidal::clearAddPlayTrack Sep 03 14:48:56 bladelius volumio[834]: info: Getting stream with soundQuality LOSSLESS Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand stop took 5 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:56 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:48:56 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand status took 10 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand clear took 10 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand status took 7 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand status took 5 milliseconds Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/9625218&soundQuality=LOSSLESS" Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:48:56 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:56 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:56 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Sep 03 14:48:56 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:48:56 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:48:56 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:48:56 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:48:56 bladelius volumio[834]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 36ms Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 33ms Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: error: updateQueue error: null Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 36ms Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand playlistinfo took 32 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/9625218&soundQuality=LOSSLESS" took 31 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 6ms Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 5ms Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::parseTrackInfo Sep 03 14:48:56 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 03 14:48:56 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand play Sep 03 14:48:56 bladelius volumio[834]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 49ms Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: info: Sep 03 14:48:56 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:48:56 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:48:56 bladelius volumio[834]: STREAMING PROXY: Handling url /?data=tidal://song/9625218&soundQuality=LOSSLESS Sep 03 14:48:56 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 15ms Sep 03 14:48:56 bladelius volumio[834]: info: sendMpdCommand play took 14 milliseconds Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 13ms Sep 03 14:48:56 bladelius volumio[834]: info: ------------------------------ 12ms Sep 03 14:48:56 bladelius volumio[834]: info: No valid Plugin REST Endpoint: getStreamUrltidal Sep 03 14:48:56 bladelius volumio[834]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl Sep 03 14:48:57 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:58 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:58 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:58 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:48:58 bladelius volumio[834]: error: Failed request for metavolumio API Sep 03 14:48:58 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:58 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:58 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:58 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:59 bladelius volumio[834]: info: Executing endpoint metavolumio Sep 03 14:48:59 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 03 14:48:59 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:00 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:01 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:02 bladelius bladelius[593]: Current volume is: 22 Sep 03 14:49:02 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:02 bladelius bladelius[593]: Current volume is: 23 Sep 03 14:49:03 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:04 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPlay Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::play index undefined Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 03 14:49:05 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::startPlaybackTimer Sep 03 14:49:05 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:49:05 bladelius volumio[834]: info: [1725367745726] ControllerTidal::clearAddPlayTrack Sep 03 14:49:05 bladelius volumio[834]: info: Getting stream with soundQuality LOSSLESS Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand stop took 2 milliseconds Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:49:05 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand clear took 2 milliseconds Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/9625218&soundQuality=LOSSLESS" Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces state update: player Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::getState Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand status Sep 03 14:49:05 bladelius volumio[834]: error: updateQueue error: null Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:49:05 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand status took 6 milliseconds Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 7ms Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/9625218&soundQuality=LOSSLESS" took 5 milliseconds Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand status took 3 milliseconds Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand status took 3 milliseconds Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::sendMpdCommand play Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:49:05 bladelius volumio[834]: verbose: ControllerMpd::parseState Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:49:05 bladelius volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 03 14:49:05 bladelius volumio[834]: verbose: CURRENT POSITION 0 Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState stateService stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState currentStatus stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: No code Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: STREAMING PROXY: Handling url /?data=tidal://song/9625218&soundQuality=LOSSLESS Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:49:05 bladelius volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 03 14:49:05 bladelius volumio[834]: verbose: CURRENT POSITION 0 Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState stateService stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState currentStatus stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: No code Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: ControllerMpd::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::servicePushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: CorePlayQueue::getTrack 0 Sep 03 14:49:05 bladelius volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 03 14:49:05 bladelius volumio[834]: verbose: CURRENT POSITION 0 Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState stateService stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::syncState currentStatus stop Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: No code Sep 03 14:49:05 bladelius volumio[834]: info: CoreStateMachine::pushState Sep 03 14:49:05 bladelius volumio[834]: info: CoreCommandRouter::volumioPushState Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output update for this device Sep 03 14:49:05 bladelius volumio[834]: info: MRS: Pushing multiroomSync output Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 64ms Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 62ms Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 62ms Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:49:05 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:49:05 bladelius volumio[834]: info: Sep 03 14:49:05 bladelius volumio[834]: ---------------------------- MPD announces system playlist update Sep 03 14:49:05 bladelius volumio[834]: info: Ignoring MPD Status Update Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 64ms Sep 03 14:49:05 bladelius volumio[834]: info: sendMpdCommand play took 62 milliseconds Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 4ms Sep 03 14:49:05 bladelius volumio[834]: info: ------------------------------ 3ms Sep 03 14:49:05 bladelius volumio[834]: info: No valid Plugin REST Endpoint: getStreamUrltidal Sep 03 14:49:05 bladelius volumio[834]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl Sep 03 14:49:06 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:06 bladelius bladelius[593]: Displaying Popup timeout, popup flag: 1725367747 - 1725367743 Sep 03 14:49:07 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:08 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:09 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:10 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:11 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:12 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:13 bladelius bladelius[593]: Current volume is: 24 Sep 03 14:49:13 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:14 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:15 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:16 bladelius bladelius[593]: Displaying Popup timeout, popup flag: 1725367757 - 1725367753 Sep 03 14:49:16 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:17 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:18 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:19 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:20 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:21 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:22 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:23 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:24 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:25 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:26 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:27 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:28 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:29 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:30 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:31 bladelius volumio[834]: info: CoreCommandRouter::volumioGetState Sep 03 14:49:32 bladelius volumio[834]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Sep 03 14:49:32 bladelius volumio[834]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Sep 03 14:49:32 bladelius volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 14:49:32 bladelius volumio[834]: TypeError: Cannot read property 'then' of undefined Sep 03 14:49:32 bladelius volumio[834]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Sep 03 14:49:32 bladelius volumio[834]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2249:30) Sep 03 14:49:32 bladelius volumio[834]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1411:26) Sep 03 14:49:32 bladelius volumio[834]: at Socket.emit (events.js:315:20) Sep 03 14:49:32 bladelius volumio[834]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Sep 03 14:49:32 bladelius volumio[834]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 03 14:49:32 bladelius volumio[834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 14:49:32 bladelius sudo[27458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-03 14:48 Sep 03 14:49:32 bladelius sudo[27458]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="bladelius" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 22 Feb 2024 11:40:29 AM CET" VOLUMIO_VERSION="3.605" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d3bdd0b3fc9d786f35abf7517805f755"