-- Logs begin at Sat 2024-07-27 08:59:06 CEST, end at Mon 2024-09-02 14:50:30 CEST. -- Sep 02 14:49:02 motivo volumio[860]: info: Preload queue cleared Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::ClearQueue Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::stop Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::stPlaybackTimer Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::updateTrackBlock Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrackBlock Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 29 Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::serviceStop Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 29 Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::serviceStop Sep 02 14:49:02 motivo volumio[860]: info: [1725281342207] ControllerQobuz::stop Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::stop Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::clearPlayQueue Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::saveQueue Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPushQueue Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::addQueueItems Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::addQueueItems Sep 02 14:49:02 motivo volumio[860]: info: Preload queue cleared Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/215727040 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/215727040 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/225811880 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/225811880 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/102368055 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/102368055 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/179875771 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/179875771 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/250643596 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/250643596 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/63484271 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/63484271 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/173228088 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/173228088 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2524150 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2524150 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/94215802 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/94215802 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/266341687 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/266341687 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/149636400 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/149636400 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/149636396 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/149636396 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/225811887 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/225811887 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/265935740 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/265935740 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/272262475 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/272262475 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/266932087 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/266932087 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/20108950 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/20108950 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/33370777 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/33370777 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/69799009 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/69799009 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/50702998 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/50702998 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/60469414 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/60469414 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/116946907 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/116946907 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/61847074 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/61847074 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/62581831 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/62581831 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/50278885 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/50278885 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/139693663 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/139693663 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/274819106 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/274819106 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/247168185 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/247168185 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/187936583 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/187936583 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/21523457 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/21523457 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/62437038 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/62437038 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/128964114 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/128964114 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/1730129 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/1730129 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/126337274 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/126337274 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/93086081 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/93086081 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/35664092 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/35664092 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/15184976 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/15184976 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/58126822 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/58126822 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/145124204 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/145124204 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/124043345 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/124043345 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/338972 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/338972 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/101897934 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/101897934 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/106547596 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/106547596 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2738121 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2738121 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/97548659 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/97548659 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/148562285 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/148562285 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/170724659 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/170724659 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/22445774 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/22445774 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/26664602 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/26664602 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/66586315 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/66586315 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/24115245 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/24115245 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/112884700 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/112884700 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/58403085 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/58403085 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/123705552 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/123705552 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/105004913 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/105004913 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/22155259 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/22155259 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/43258968 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/43258968 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/171487073 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/171487073 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/54992275 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/54992275 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/51778633 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/51778633 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2367658 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2367658 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/34811697 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/34811697 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/297557 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/297557 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/13144687 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/13144687 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/170695444 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/170695444 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/129295012 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/129295012 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/34727887 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/34727887 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4744569 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4744569 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/158131714 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/158131714 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/61329554 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/61329554 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/14868174 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/14868174 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/8581502 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/8581502 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/44079976 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/44079976 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/17578 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/17578 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/35927312 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/35927312 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/30325606 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/30325606 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/10472819 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/10472819 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/77524662 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/77524662 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/40452676 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/40452676 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/27582763 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/27582763 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/51779845 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/51779845 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/8019030 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/8019030 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/50672011 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/50672011 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/732450 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/732450 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/14283568 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/14283568 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/166730638 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/166730638 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/169872349 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/169872349 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/172714552 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/172714552 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/172714547 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/172714547 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/26460064 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/26460064 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/5378403 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/5378403 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/369340 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/369340 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/12627981 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/12627981 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/169163862 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/169163862 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/5948602 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/5948602 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/120407637 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/120407637 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/105582423 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/105582423 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4620232 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4620232 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/92580171 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/92580171 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/143429434 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/143429434 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/46627710 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/46627710 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/80648935 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/80648935 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/44068513 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/44068513 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/96893176 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/96893176 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/40703578 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/40703578 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/1405693 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/1405693 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/79758209 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/79758209 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/97253278 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/97253278 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/63200720 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/63200720 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/87682311 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/87682311 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/3562544 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/3562544 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/127313931 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/127313931 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/56906556 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/56906556 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4887308 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4887308 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2337929 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2337929 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/77516858 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/77516858 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/52258 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/52258 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2218511 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2218511 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/102019604 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/102019604 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/7907138 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/7907138 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/41719558 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/41719558 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/62538563 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/62538563 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/127696721 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/127696721 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/147749224 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/147749224 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/57751721 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/57751721 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/1940697 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/1940697 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/24310436 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/24310436 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/13477648 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/13477648 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/53255326 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/53255326 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/54215021 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/54215021 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/13968716 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/13968716 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/91450206 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/91450206 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/117306340 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/117306340 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4716679 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4716679 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/3896986 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/3896986 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/57751720 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/57751720 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/23706178 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/23706178 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2838037 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2838037 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/87679399 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/87679399 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/8524919 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/8524919 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/12262293 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/12262293 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4911502 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4911502 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/7216731 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/7216731 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/7216729 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/7216729 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/30665340 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/30665340 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/141295371 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/141295371 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4308003 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4308003 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/33546473 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/33546473 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/4589203 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/4589203 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/6004883 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/6004883 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/13699663 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/13699663 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2396142 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2396142 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/14164214 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/14164214 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/85881757 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/85881757 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/2858138 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/2858138 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/102874103 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/102874103 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/32378052 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/32378052 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/797846 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/797846 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/77204073 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/77204073 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/49298572 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/49298572 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/31866282 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/31866282 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/79760832 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/79760832 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/89454861 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/89454861 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/144401057 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/144401057 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/87221818 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/87221818 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/79173781 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/79173781 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/5683570 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/5683570 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/85665116 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/85665116 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/91112957 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/91112957 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/84393391 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/84393391 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/90272117 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/90272117 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/91450174 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/91450174 Sep 02 14:49:02 motivo volumio[860]: info: Adding Item to queue: qobuz://song/87149289 Sep 02 14:49:02 motivo volumio[860]: info: Using cached record of: qobuz://song/87149289 Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPushQueue Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::saveQueue Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::updateTrackBlock Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrackBlock Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPlay Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::play index 9 Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::stop Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::play index undefined Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::startPlaybackTimer Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: [1725281342315] ControllerQobuz::clearAddPlayTrack Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 14:49:02 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand stop took 139 milliseconds Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand stop took 32 milliseconds Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand clear Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand status took 7 milliseconds Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand clear took 7 milliseconds Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand status took 6 milliseconds Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/266341687" Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Handling url /?data=qobuz://song/266341687 Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:02 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:02 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:02 motivo volumio[860]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 25ms Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 25ms Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: error: updateQueue error: null Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 24ms Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand playlistinfo took 22 milliseconds Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:02 motivo volumio[860]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 33ms Sep 02 14:49:02 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:02 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:02 motivo volumio[860]: info: Executing endpoint getStreamUrlqobuz Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Sep 02 14:49:02 motivo volumio[860]: info: MCU Signalled Playback Inactive Sep 02 14:49:02 motivo volumio[860]: info: getStreamUrl took 162 milliseconds Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1320017&eid=266341687&fmt=7&profile=raw&app_id=539451548&cid=1889689&etsp=1725284942&hmac=w5WAix1f5Rgig6QjyByvs6sveek Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Response: 200, length: 55527236 Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Client dropped request, destroying Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/266341687" Sep 02 14:49:02 motivo volumio[860]: error: updateQueue error: null Sep 02 14:49:02 motivo volumio[860]: error: updateQueue error: null Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 327ms Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 326ms Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/266341687" took 2 milliseconds Sep 02 14:49:02 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand play Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces system playlist update Sep 02 14:49:02 motivo volumio[860]: info: Ignoring MPD Status Update Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Handling url /?data=qobuz://song/266341687 Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 6ms Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand play took 4 milliseconds Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 3ms Sep 02 14:49:02 motivo volumio[860]: info: ------------------------------ 2ms Sep 02 14:49:02 motivo volumio[860]: info: Executing endpoint getStreamUrlqobuz Sep 02 14:49:02 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Sep 02 14:49:02 motivo volumio[860]: info: getStreamUrl took 194 milliseconds Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1320017&eid=266341687&fmt=7&profile=raw&app_id=539451548&cid=1889689&etsp=1725284942&hmac=w5WAix1f5Rgig6QjyByvs6sveek Sep 02 14:49:02 motivo volumio[860]: STREAMING PROXY: Response: 200, length: 55527236 Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: Sep 02 14:49:02 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:02 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:02 motivo volumio[860]: info: sendMpdCommand status took 30 milliseconds Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:02 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: info: Sep 02 14:49:03 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:03 motivo volumio[860]: info: Sep 02 14:49:03 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:03 motivo volumio[860]: info: Sep 02 14:49:03 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand status took 50 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand status took 49 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 22 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand status took 9 milliseconds Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus stop Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 69ms Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand status took 24 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand status took 22 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 14 milliseconds Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2152 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:03 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2161 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:03 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":330,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2155 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:03 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 145ms Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 144ms Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 108ms Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 74 milliseconds Sep 02 14:49:03 motivo volumio[860]: info: sendMpdCommand playlistinfo took 75 milliseconds Sep 02 14:49:03 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2150 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:03 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:03 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:03 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1112,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2182 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:03 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:03 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:03 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:03 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 152ms Sep 02 14:49:03 motivo volumio[860]: info: ------------------------------ 152ms Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:03 motivo volumio[860]: info: MCU Signalled Playback Active Sep 02 14:49:03 motivo volumio[860]: STREAMING PROXY: Client dropped request, destroying Sep 02 14:49:42 motivo volumio[860]: verbose: New Socket.io Connection to 192.168.1.131 from 192.168.1.160 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::volumioGetVisibleSources Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::volumioGetState Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::volumioGetQueue Sep 02 14:49:42 motivo volumio[860]: info: CoreStateMachine::getQueue Sep 02 14:49:42 motivo volumio[860]: info: CorePlayQueue::getQueue Sep 02 14:49:42 motivo volumio[860]: info: Listing playlists Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 02 14:49:42 motivo volumio[860]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 02 14:49:42 motivo volumio[860]: info: Received Get System Info Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 14:49:42 motivo volumio[860]: info: Discovery: Getting this device information Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::volumioGetState Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::volumioGetState Sep 02 14:49:42 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioSeek Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::seek Sep 02 14:49:46 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:46 motivo volumio[860]: info: TRACKBLOCK {"uri":"qobuz://song/266341687","service":"qobuz","name":"Sapias","title":"Sapias","album":"LIFE","type":"track","tracknumber":2,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/nb/ps/yaekwe25tpsnb_600.jpg","duration":180,"explicit":false,"artist":"Mari Samuelsen","artistUri":"qobuz://artist/2117040","albumUri":"qobuz://album/yaekwe25tpsnb","audioQuality":"","tagImage":""} Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::startPlaybackTimer Sep 02 14:49:46 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:46 motivo volumio[860]: info: [1725281386153] ControllerQobuz::seek Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::seek Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: error: null Sep 02 14:49:46 motivo volumio[860]: info: Sep 02 14:49:46 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:46 motivo volumio[860]: info: Sep 02 14:49:46 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:46 motivo volumio[860]: info: Sep 02 14:49:46 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:46 motivo volumio[860]: info: sendMpdCommand status took 14 milliseconds Sep 02 14:49:46 motivo volumio[860]: info: sendMpdCommand status took 4 milliseconds Sep 02 14:49:46 motivo volumio[860]: info: sendMpdCommand status took 3 milliseconds Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:46 motivo volumio[860]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 02 14:49:46 motivo volumio[860]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:46 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:46 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:46 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2300 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:46 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:46 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:46 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:46 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71244,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2674 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:46 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:46 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:46 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:46 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71244,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2758 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:46 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:46 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:46 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:46 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:46 motivo volumio[860]: info: ------------------------------ 64ms Sep 02 14:49:46 motivo volumio[860]: info: ------------------------------ 64ms Sep 02 14:49:46 motivo volumio[860]: info: ------------------------------ 55ms Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:46 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:53 motivo volumio[860]: info: CoreCommandRouter::volumioSeek Sep 02 14:49:53 motivo volumio[860]: info: CoreStateMachine::seek Sep 02 14:49:53 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:53 motivo volumio[860]: info: TRACKBLOCK {"uri":"qobuz://song/266341687","service":"qobuz","name":"Sapias","title":"Sapias","album":"LIFE","type":"track","tracknumber":2,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/nb/ps/yaekwe25tpsnb_600.jpg","duration":180,"explicit":false,"artist":"Mari Samuelsen","artistUri":"qobuz://artist/2117040","albumUri":"qobuz://album/yaekwe25tpsnb","audioQuality":"","tagImage":""} Sep 02 14:49:53 motivo volumio[860]: info: CoreStateMachine::startPlaybackTimer Sep 02 14:49:53 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:53 motivo volumio[860]: info: [1725281393955] ControllerQobuz::seek Sep 02 14:49:53 motivo volumio[860]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 02 14:49:53 motivo volumio[860]: info: ControllerMpd::seek Sep 02 14:49:53 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:53 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:53 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:53 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:53 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:53 motivo volumio[860]: error: null Sep 02 14:49:53 motivo volumio[860]: info: Sep 02 14:49:53 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:53 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:53 motivo volumio[860]: info: Sep 02 14:49:53 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:53 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:53 motivo volumio[860]: info: Sep 02 14:49:53 motivo volumio[860]: ---------------------------- MPD announces state update: player Sep 02 14:49:53 motivo volumio[860]: info: ControllerMpd::getState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand status Sep 02 14:49:53 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:53 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand status took 16 milliseconds Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand status took 14 milliseconds Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand status took 12 milliseconds Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::parseState Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 02 14:49:53 motivo volumio[860]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:53 motivo volumio[860]: verbose: ControllerMpd::parseTrackInfo Sep 02 14:49:53 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:54 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:54 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100000,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2723 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:54 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:54 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:54 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:54 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100000,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2723 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:54 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:54 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: ControllerMpd::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::servicePushState Sep 02 14:49:54 motivo volumio[860]: info: CorePlayQueue::getTrack 9 Sep 02 14:49:54 motivo volumio[860]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100000,"duration":180,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2723 Kbps","isStreaming":false,"title":"266341687","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/266341687","trackType":"qobuz"} Sep 02 14:49:54 motivo volumio[860]: verbose: CURRENT POSITION 9 Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState stateService play Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::syncState currentStatus play Sep 02 14:49:54 motivo volumio[860]: info: Received an update from plugin. extracting info from payload Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: CoreStateMachine::pushState Sep 02 14:49:54 motivo volumio[860]: info: CoreCommandRouter::volumioPushState Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output update for this device Sep 02 14:49:54 motivo volumio[860]: info: MRS: Pushing multiroomSync output Sep 02 14:49:54 motivo volumio[860]: info: ------------------------------ 61ms Sep 02 14:49:54 motivo volumio[860]: info: ------------------------------ 60ms Sep 02 14:49:54 motivo volumio[860]: info: ------------------------------ 58ms Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Signalling Playback active due to playback status change Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:49:54 motivo volumio[860]: info: Updating RAAT Signal Path Sep 02 14:50:30 motivo volumio[860]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Sep 02 14:50:30 motivo volumio[860]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 14:50:30 motivo volumio[860]: TypeError: Cannot read property 'then' of undefined Sep 02 14:50:30 motivo volumio[860]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Sep 02 14:50:30 motivo volumio[860]: at Socket.emit (events.js:315:20) Sep 02 14:50:30 motivo volumio[860]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Sep 02 14:50:30 motivo volumio[860]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 02 14:50:30 motivo volumio[860]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 14:50:30 motivo sudo[14299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-02 14:49 Sep 02 14:50:30 motivo sudo[14299]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 05:28:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="7c8d25c95f72295d622ec3282883fbc6"