-- Logs begin at Wed 2025-10-22 23:05:33 EDT, end at Fri 2025-10-24 20:58:03 EDT. -- Oct 24 20:57:00 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:04 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:05 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:05 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:05 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:57:05 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:05 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:05 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:05 volumio-shd volumio[12864]: info: Updating RAAT Signal Path Oct 24 20:57:05 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:08 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:12 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:14 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:14-04:00" level=trace msg="received accesspoint ping" Oct 24 20:57:14 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:14-04:00" level=trace msg="received accesspoint pong ack" Oct 24 20:57:16 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:17 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 20:57:17 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 20:57:17 volumio-shd volumio[12864]: info: Discovery: Getting this device information Oct 24 20:57:17 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioGetState Oct 24 20:57:17 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 20:57:20 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:24 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:25 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:25 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:25 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:57:25 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:25 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:25 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:25 volumio-shd volumio[12864]: info: Updating RAAT Signal Path Oct 24 20:57:25 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:28 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:29 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:29-04:00" level=trace msg="sent dealer ping" Oct 24 20:57:29 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:29-04:00" level=trace msg="received dealer pong" Oct 24 20:57:32 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:34 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand update Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: Oct 24 20:57:34 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand update took 13 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: Oct 24 20:57:34 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:34 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: Oct 24 20:57:34 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:34 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 28 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:34 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatetrue Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: Oct 24 20:57:34 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:34 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 109 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 108 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 104 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 104 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: info: sendMpdCommand status took 109 milliseconds Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:34 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:34 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:34 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 272ms Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 268ms Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 265ms Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:35 volumio-shd volumio[12864]: info: Oct 24 20:57:35 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:35 volumio-shd volumio[12864]: info: Oct 24 20:57:35 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 205 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 203 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 38 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 35 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 35 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: info: sendMpdCommand status took 33 milliseconds Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:35 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:35 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:35 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:35 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 390ms Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 221ms Oct 24 20:57:35 volumio-shd volumio[12864]: info: ------------------------------ 218ms Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:35 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:36 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:37 volumio-shd volumiologrotate[457]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 24 20:57:37 volumio-shd volumiologrotate[457]: ls: cannot access 'SHD': No such file or directory Oct 24 20:57:40 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:44 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:45 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:45 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:45 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:57:45 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:45 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:45 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:45 volumio-shd volumio[12864]: info: Updating RAAT Signal Path Oct 24 20:57:45 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand rescan Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand rescan took 9 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 7 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 4 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 113ms Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 124 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 123 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 13 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 11 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 9 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 7 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 299ms Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 189ms Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 184ms Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: info: Oct 24 20:57:46 volumio-shd volumio[12864]: ---------------------------- MPD announces state update: update Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::getState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 30 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 29 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 27 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: info: sendMpdCommand status took 26 milliseconds Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: Command Router : Notfying DB Updatefalse Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::Close All Modals sent Oct 24 20:57:46 volumio-shd volumio[12864]: verbose: ControllerMpd::parseState Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ControllerMpd::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::servicePushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreStateMachine::pushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioPushState Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output update for this device Oct 24 20:57:46 volumio-shd volumio[12864]: info: MRS: Pushing multiroomSync output Oct 24 20:57:46 volumio-shd volumio[12864]: info: CorePlayQueue::getTrack 0 Oct 24 20:57:46 volumio-shd volumio[12864]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current soundcloud Received mpd Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 150ms Oct 24 20:57:46 volumio-shd volumio[12864]: info: ------------------------------ 147ms Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:46 volumio-shd volumio[12864]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 24 20:57:47 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 20:57:47 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 20:57:47 volumio-shd volumio[12864]: info: Discovery: Getting this device information Oct 24 20:57:47 volumio-shd volumio[12864]: info: CoreCommandRouter::volumioGetState Oct 24 20:57:47 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 20:57:48 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:52 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:56 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:57:57 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 24 20:57:57 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 24 20:57:59 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:59-04:00" level=trace msg="sent dealer ping" Oct 24 20:57:59 volumio-shd go-librespot[14119]: time="2025-10-24T20:57:59-04:00" level=trace msg="received dealer pong" Oct 24 20:57:59 volumio-shd volumio[12864]: info: Error browsing device Lasso's MacBook Pro for shares : Error: Command failed: echo volumio | smbclient -L DontYouKnowIm.local. Oct 24 20:57:59 volumio-shd volumio[12864]: Unable to initialize messaging context Oct 24 20:58:00 volumio-shd volumio[12864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 20:58:02 volumio-shd volumio[12864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:58:02 volumio-shd volumio[12864]: Error: dns service error: unknown Oct 24 20:58:02 volumio-shd volumio[12864]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 24 20:58:02 volumio-shd volumio[12864]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 24 20:58:02 volumio-shd volumio[12864]: errorCode: -65537 Oct 24 20:58:02 volumio-shd volumio[12864]: } Oct 24 20:58:02 volumio-shd volumio[12864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:58:03 volumio-shd sudo[16825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 20:57 Oct 24 20:58:03 volumio-shd sudo[16825]: 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="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"