-- Logs begin at Fri 2024-09-06 19:08:01 CEST, end at Fri 2024-09-06 19:48:52 CEST. -- Sep 06 19:47:06 integro-office volumio[3151]: STREAMING PROXY: Client dropped request, destroying Sep 06 19:48:33 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Sep 06 19:48:34 integro-office volumio[3151]: info: handleBrowseUri took 892 milliseconds Sep 06 19:48:34 integro-office volumio[3151]: info: Preload queue cleared Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415773 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415774 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415775 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415776 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415777 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415778 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415779 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415780 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415781 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415782 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415783 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415784 Sep 06 19:48:34 integro-office volumio[3151]: info: Preloading song: qobuz://song/10415785 Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415773 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415774 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415775 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415776 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415777 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415778 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415779 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415780 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415781 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415782 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415783 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415784 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: Exploding uri qobuz://song/10415785 in service qobuz Sep 06 19:48:34 integro-office volumio[3151]: https://browsing-performer.prod.vlmapi.io/volumio2/qobuz/explodeUri Sep 06 19:48:34 integro-office volumio[3151]: info: explodeUri took 716 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 688 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 814 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 787 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 661 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 944 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 1073 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 773 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 972 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 727 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 1038 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 1023 milliseconds Sep 06 19:48:35 integro-office volumio[3151]: info: explodeUri took 935 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint getSimilarAlbums Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:36 integro-office volumio[3151]: info: Preload queue cleared Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::ClearQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::stop Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::stPlaybackTimer Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::updateTrackBlock Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrackBlock Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 2 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::serviceStop Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 2 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::serviceStop Sep 06 19:48:36 integro-office volumio[3151]: info: [1725644916825] ControllerQobuz::stop Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::stop Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand stop Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::clearPlayQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::saveQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::addQueueItems Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::addQueueItems Sep 06 19:48:36 integro-office volumio[3151]: info: Preload queue cleared Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415773 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415773 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415774 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415774 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415775 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415775 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415776 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415776 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415777 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415777 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415778 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415778 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415779 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415779 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415780 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415780 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415781 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415781 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415782 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415782 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415783 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415783 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415784 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415784 Sep 06 19:48:36 integro-office volumio[3151]: info: Adding Item to queue: qobuz://song/10415785 Sep 06 19:48:36 integro-office volumio[3151]: info: Using cached record of: qobuz://song/10415785 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::saveQueue Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::updateTrackBlock Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrackBlock Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPlay Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::play index 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::stop Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::play index undefined Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::startPlaybackTimer Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: [1725644916855] ControllerQobuz::clearAddPlayTrack Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand stop Sep 06 19:48:36 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:36 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:36 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:36 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand stop took 61 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand stop took 31 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand clear Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 16 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand clear took 15 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 14 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 13 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 11 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 10 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: info: sendMpdCommand status took 9 milliseconds Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/10415773" Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:36 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: STREAMING PROXY: Handling url /?data=qobuz://song/10415773 Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:36 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:36 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:36 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:36 integro-office volumio[3151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Sep 06 19:48:36 integro-office volumio[3151]: info: ------------------------------ 90ms Sep 06 19:48:36 integro-office volumio[3151]: info: ------------------------------ 90ms Sep 06 19:48:36 integro-office volumio[3151]: info: ------------------------------ 89ms Sep 06 19:48:36 integro-office volumio[3151]: info: ------------------------------ 88ms Sep 06 19:48:36 integro-office volumio[3151]: info: ------------------------------ 88ms Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:36 integro-office volumio[3151]: info: Sep 06 19:48:36 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:36 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:37 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:37 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:37 integro-office volumio[3151]: info: ------------------------------ 135ms Sep 06 19:48:37 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 132 milliseconds Sep 06 19:48:37 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:37 integro-office volumio[3151]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 06 19:48:37 integro-office volumio[3151]: info: ------------------------------ 152ms Sep 06 19:48:37 integro-office volumio[3151]: info: Executing endpoint getStreamUrlqobuz Sep 06 19:48:37 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Sep 06 19:48:37 integro-office volumio[3151]: info: MCU Signalled Playback Inactive Sep 06 19:48:37 integro-office volumio[3151]: info: getStreamUrl took 729 milliseconds Sep 06 19:48:37 integro-office volumio[3151]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=376682&eid=10415773&fmt=6&profile=raw&app_id=539451548&cid=1346919&etsp=1725648517&hmac=5UV1JRyiWgeGC5v0A6bEXqLQnCs Sep 06 19:48:38 integro-office volumio[3151]: STREAMING PROXY: Response: 200, length: 26278478 Sep 06 19:48:38 integro-office volumio[3151]: STREAMING PROXY: Client dropped request, destroying Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/10415773" Sep 06 19:48:38 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:38 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:38 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:38 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:38 integro-office volumio[3151]: error: updateQueue error: null Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 1091ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 1090ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 1089ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 1087ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 1086ms Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/10415773" took 4 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand play Sep 06 19:48:38 integro-office volumio[3151]: STREAMING PROXY: Handling url /?data=qobuz://song/10415773 Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces system playlist update Sep 06 19:48:38 integro-office volumio[3151]: info: Ignoring MPD Status Update Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 15ms Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand play took 13 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 10ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 9ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 7ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 7ms Sep 06 19:48:38 integro-office volumio[3151]: info: ------------------------------ 5ms Sep 06 19:48:38 integro-office volumio[3151]: info: Executing endpoint getStreamUrlqobuz Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Sep 06 19:48:38 integro-office volumio[3151]: info: getStreamUrl took 731 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=376682&eid=10415773&fmt=6&profile=raw&app_id=539451548&cid=1346919&etsp=1725648518&hmac=WQxs2QPORYRMNQK6ZmH_pcX4yGM Sep 06 19:48:38 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:38 integro-office volumio[3151]: STREAMING PROXY: Response: 200, length: 26278478 Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 13 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 12 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 10 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 8 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 7 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 10 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: Sep 06 19:48:38 integro-office volumio[3151]: ---------------------------- MPD announces state update: player Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::getState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand status Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 24 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 12 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 10 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 9 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 7 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: info: sendMpdCommand status took 6 milliseconds Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::parseState Sep 06 19:48:38 integro-office volumio[3151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:38 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:38 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:38 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus stop Sep 06 19:48:38 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:38 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:38 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:38 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:38 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:38 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:38 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:38 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:38 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:38 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 118ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 165ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 164ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 162ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 162ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 161ms Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 134 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 131 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 132 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 132 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 132 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: info: sendMpdCommand playlistinfo took 132 milliseconds Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: verbose: ControllerMpd::parseTrackInfo Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ControllerMpd::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::servicePushState Sep 06 19:48:39 integro-office volumio[3151]: info: CorePlayQueue::getTrack 0 Sep 06 19:48:39 integro-office volumio[3151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10415773","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/10415773","trackType":"qobuz"} Sep 06 19:48:39 integro-office volumio[3151]: verbose: CURRENT POSITION 0 Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState stateService play Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::syncState currentStatus play Sep 06 19:48:39 integro-office volumio[3151]: info: Received an update from plugin. extracting info from payload Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: CoreStateMachine::pushState Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::volumioPushState Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output update for this device Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Pushing multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 297ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 283ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 283ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 282ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 281ms Sep 06 19:48:39 integro-office volumio[3151]: info: ------------------------------ 281ms Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: info: Signalling Playback active due to playback status change Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: SPOTIFY VOLUME 33 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: VOLUMIO VOLUME 34 Sep 06 19:48:39 integro-office volumio[3151]: SPOTIFY: DELTA VOLUME ENOUGH: false Sep 06 19:48:39 integro-office volumio[3151]: info: MRS: Updating multiroomSync output Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:39 integro-office volumio[3151]: info: MCU Signalled Playback Active Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:39 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:39 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:41 integro-office volumio[3151]: info: Executing endpoint metavolumio Sep 06 19:48:41 integro-office volumio[3151]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 06 19:48:52 integro-office volumio[3151]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 19:48:52 integro-office volumio[3151]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net Sep 06 19:48:52 integro-office volumio[3151]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Sep 06 19:48:52 integro-office volumio[3151]: errno: -3007, Sep 06 19:48:52 integro-office volumio[3151]: code: 'ENOTFOUND', Sep 06 19:48:52 integro-office volumio[3151]: syscall: 'getaddrinfo', Sep 06 19:48:52 integro-office volumio[3151]: hostname: 'lastfm.freetls.fastly.net' Sep 06 19:48:52 integro-office volumio[3151]: } Sep 06 19:48:52 integro-office volumio[3151]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 19:48:52 integro-office sudo[10174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 19:47 Sep 06 19:48:52 integro-office sudo[10174]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="integro" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 01 Aug 2024 05:17:04 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Integro" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Integro" VOLUMIO_HASH="56b9d3932cd0f553ab78e4b3e169d42c"