-- Logs begin at Fri 2025-09-05 14:32:36 EDT, end at Fri 2025-09-05 17:45:52 EDT. -- Sep 05 17:44:01 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:44:01 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:44:16 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:44:16 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:44:31 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:44:31 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:44:47 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:44:47 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:44:50 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Sep 05 17:44:50 volumio-mac volumio[1419]: info: MRS: Starting browser stream Sep 05 17:44:50 volumio-mac volumio[1419]: info: MRS: Setting this device as single Sep 05 17:44:50 volumio-mac volumio[1419]: info: Sep 05 17:44:50 volumio-mac volumio[1419]: [1757108690748] ---------------------------- Setting Multiroom Single Sep 05 17:44:50 volumio-mac volumio[1419]: info: MRS: disable multiroom output Sep 05 17:44:50 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioDiscard Sep 05 17:44:50 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Sep 05 17:44:51 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 05 17:44:51 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Sep 05 17:44:52 volumio-mac volumio[1419]: info: MRS: STOPPING volumioStreaming Sep 05 17:44:52 volumio-mac sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 05 17:44:52 volumio-mac sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:44:52 volumio-mac systemd[1]: Stopping VolumioStreamingService... Sep 05 17:44:52 volumio-mac systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Sep 05 17:44:52 volumio-mac systemd[1]: volumioStreaming.service: Succeeded. Sep 05 17:44:52 volumio-mac systemd[1]: Stopped VolumioStreamingService. Sep 05 17:44:52 volumio-mac sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:44:52 volumio-mac sudo[1027]: pam_unix(sudo:session): session closed for user root Sep 05 17:44:52 volumio-mac sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:44:52 volumio-mac volumio[1419]: info: MRS: volumioStreaming STOPPED Sep 05 17:44:52 volumio-mac sudo[1030]: pam_unix(sudo:session): session closed for user root Sep 05 17:44:52 volumio-mac volumio[1419]: info: MRS: Removed streaming files Sep 05 17:44:56 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: Starting cast device: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 05 17:44:56 volumio-mac volumio[1419]: info: Enabled audio output: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: Setting this device as Streaming Server Sep 05 17:44:56 volumio-mac volumio[1419]: info: Sep 05 17:44:56 volumio-mac volumio[1419]: [1757108696583] ---------------------------- MRS: Setting Streaming Server Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: enable multiroom server output Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioMultiRoom Sep 05 17:44:56 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 05 17:44:56 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: STARTING volumioStreaming Sep 05 17:44:56 volumio-mac sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:44:56 volumio-mac sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:44:56 volumio-mac sudo[1057]: pam_unix(sudo:session): session closed for user root Sep 05 17:44:56 volumio-mac sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Sep 05 17:44:56 volumio-mac sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:44:56 volumio-mac systemd[1]: Started VolumioStreamingService. Sep 05 17:44:56 volumio-mac sudo[1060]: pam_unix(sudo:session): session closed for user root Sep 05 17:44:56 volumio-mac volumio[1419]: info: MRS: volumioStreaming STARTED Sep 05 17:44:56 volumio-mac sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:44:56 volumio-mac sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:44:56 volumio-mac sudo[1063]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:02 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:45:02 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:45:02 volumio-mac volumio[1419]: info: VolumeController::SetAlsaVolume100 Sep 05 17:45:02 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:45:02 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:45:02 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:02 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:45:02 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 17:45:02 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:02 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:02 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:02 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:02 volumio-mac volumio[1419]: SPOTIFY: SPOTIFY VOLUME 86 Sep 05 17:45:02 volumio-mac volumio[1419]: SPOTIFY: VOLUMIO VOLUME 100 Sep 05 17:45:02 volumio-mac volumio[1419]: SPOTIFY: DELTA VOLUME ENOUGH: true Sep 05 17:45:02 volumio-mac volumio[1419]: info: Setting Spotify Volume from Volumio: 100 Sep 05 17:45:03 volumio-mac volumio[1419]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Sep 05 17:45:03 volumio-mac volumio[1419]: info: Sending Spotify command with payload to local API: /player/volume Sep 05 17:45:06 volumio-mac volumio[1419]: info: Executing endpoint metavolumio Sep 05 17:45:06 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 05 17:45:06 volumio-mac volumio[1419]: info: Executing endpoint metavolumio Sep 05 17:45:06 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 05 17:45:12 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 05 17:45:12 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:14 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 05 17:45:14 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:17 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:45:17 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 9 Sep 05 17:45:18 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::ClearQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::stop Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::clearPlayQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::saveQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::addQueueItems Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::addQueueItems Sep 05 17:45:18 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:18 volumio-mac volumio[1419]: info: Adding Item to queue: https://proxima.shoutca.st/tunein/ataraxy.pls Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::saveQueue Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::updateTrackBlock Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::getTrackBlock Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPlay Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::play index 0 Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::stop Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::play index undefined Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreStateMachine::startPlaybackTimer Sep 05 17:45:18 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 17:45:18 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 05 17:45:18 volumio-mac volumio[1419]: info: [1757108718776] ControllerWebradio::clearAddPlayTrack Sep 05 17:45:18 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 17:45:18 volumio-mac volumio[1419]: info: sendMpdCommand stop took 2 milliseconds Sep 05 17:45:18 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 17:45:18 volumio-mac volumio[1419]: info: sendMpdCommand clear took 0 milliseconds Sep 05 17:45:18 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand load "https://proxima.shoutca.st/tunein/ataraxy.pls" Sep 05 17:45:18 volumio-mac volumio[1419]: info: Sep 05 17:45:18 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Sep 05 17:45:18 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Sep 05 17:45:18 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Sep 05 17:45:18 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:18 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:20 volumio-mac volumio[1419]: error: updateQueue error: null Sep 05 17:45:20 volumio-mac volumio[1419]: error: updateQueue error: null Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand add "https://proxima.shoutca.st/tunein/ataraxy.pls" Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1566ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1566ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1566ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1567ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand add "https://proxima.shoutca.st/tunein/ataraxy.pls" took 1 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand play Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:20 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand play took 2 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 2ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 1ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:20 volumio-mac volumio[1419]: info: Sep 05 17:45:20 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand status took 4 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand clearerror took 6 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand clearerror took 6 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand clearerror took 5 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand clearerror took 5 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ataraxy.pls","artist":null,"album":null,"uri":"https://proxima.shoutca.st/tunein/ataraxy.pls","trackType":"pls"} Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: No code Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ataraxy.pls","artist":null,"album":null,"uri":"https://proxima.shoutca.st/tunein/ataraxy.pls","trackType":"pls"} Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: No code Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ataraxy.pls","artist":null,"album":null,"uri":"https://proxima.shoutca.st/tunein/ataraxy.pls","trackType":"pls"} Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: No code Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ataraxy.pls","artist":null,"album":null,"uri":"https://proxima.shoutca.st/tunein/ataraxy.pls","trackType":"pls"} Sep 05 17:45:20 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus stop Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: No code Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:20 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 63ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 62ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 62ms Sep 05 17:45:20 volumio-mac volumio[1419]: info: ------------------------------ 62ms Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:20 volumio-mac volumio[1419]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.l6fjprgQeOfTH4c2lFff4r3TmCr1.bc6561faf3525282fee4fc4dfdf8523d.state.status' Sep 05 17:45:22 volumio-mac volumio[1419]: info: Executing endpoint metavolumio Sep 05 17:45:22 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 05 17:45:23 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::ClearQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::stop Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::clearPlayQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::saveQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::addQueueItems Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::addQueueItems Sep 05 17:45:23 volumio-mac volumio[1419]: info: Preload queue cleared Sep 05 17:45:23 volumio-mac volumio[1419]: info: Adding Item to queue: https://dancewave.online/dance.flac.ogg.pls Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::saveQueue Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::updateTrackBlock Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::getTrackBlock Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPlay Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::play index 0 Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::stop Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::play index undefined Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreStateMachine::startPlaybackTimer Sep 05 17:45:23 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 17:45:23 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 05 17:45:23 volumio-mac volumio[1419]: info: [1757108723332] ControllerWebradio::clearAddPlayTrack Sep 05 17:45:23 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 17:45:23 volumio-mac volumio[1419]: info: sendMpdCommand stop took 4 milliseconds Sep 05 17:45:23 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 17:45:23 volumio-mac volumio[1419]: info: Sep 05 17:45:23 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:23 volumio-mac volumio[1419]: info: sendMpdCommand clear took 1 milliseconds Sep 05 17:45:23 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand load "https://dancewave.online/dance.flac.ogg.pls" Sep 05 17:45:23 volumio-mac volumio[1419]: info: Sep 05 17:45:23 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Sep 05 17:45:23 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Sep 05 17:45:23 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:23 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:23 volumio-mac volumio[1419]: error: updateQueue error: null Sep 05 17:45:23 volumio-mac volumio[1419]: info: ------------------------------ 4ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: Sep 05 17:45:25 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:25 volumio-mac volumio[1419]: info: sendMpdCommand load "https://dancewave.online/dance.flac.ogg.pls" took 1812 milliseconds Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 1811ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 1811ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 1811ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 05 17:45:25 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand play Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 2ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: Sep 05 17:45:25 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Sep 05 17:45:25 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Sep 05 17:45:25 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:25 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:25 volumio-mac volumio[1419]: info: sendMpdCommand play took 3 milliseconds Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 3ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 2ms Sep 05 17:45:25 volumio-mac volumio[1419]: info: ------------------------------ 1ms Sep 05 17:45:26 volumio-mac volumio[1419]: info: Sep 05 17:45:26 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:26 volumio-mac volumio[1419]: info: Sep 05 17:45:26 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:26 volumio-mac volumio[1419]: info: Sep 05 17:45:26 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:26 volumio-mac volumio[1419]: info: Sep 05 17:45:26 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand status took 3 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand status took 2 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand status took 3 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand status took 2 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"http://dancewave.online/dance.flac.ogg","artist":null,"album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus stop Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"http://dancewave.online/dance.flac.ogg","artist":null,"album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:26 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"http://dancewave.online/dance.flac.ogg","artist":null,"album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:26 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"http://dancewave.online/dance.flac.ogg","artist":null,"album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:26 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:26 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:26 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:26 volumio-mac volumio[1419]: info: ------------------------------ 33ms Sep 05 17:45:26 volumio-mac volumio[1419]: info: ------------------------------ 43ms Sep 05 17:45:26 volumio-mac volumio[1419]: info: ------------------------------ 44ms Sep 05 17:45:26 volumio-mac volumio[1419]: info: ------------------------------ 44ms Sep 05 17:45:26 volumio-mac volumio[1419]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Dance Wave FLAC Sep 05 17:45:26 volumio-mac volumio[1419]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Dance Wave FLAC Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:26 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces system playlist update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Ignoring MPD Status Update Sep 05 17:45:27 volumio-mac volumio[1419]: info: Sep 05 17:45:27 volumio-mac volumio[1419]: ---------------------------- MPD announces state update: player Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::getState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand status Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 7ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 5ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 6ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 5ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand status took 5 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseState Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: ControllerMpd::parseTrackInfo Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:27 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:27 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:27 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: ControllerMpd::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::servicePushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CorePlayQueue::getTrack 0 Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1206,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dance Wave!","artist":"Dance Wave!","album":null,"uri":"http://dancewave.online/dance.flac.ogg","trackType":"ogg"} Sep 05 17:45:27 volumio-mac volumio[1419]: verbose: CURRENT POSITION 0 Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState stateService play Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::syncState currentStatus play Sep 05 17:45:27 volumio-mac volumio[1419]: info: Received an update from plugin. extracting info from payload Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreStateMachine::pushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioPushState Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output update for this device Sep 05 17:45:27 volumio-mac volumio[1419]: info: MRS: Pushing multiroomSync output Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 51ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 49ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 50ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: ------------------------------ 49ms Sep 05 17:45:27 volumio-mac volumio[1419]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist (Dance Wave!) passed on explicitly Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 05 17:45:27 volumio-mac volumio[1419]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21/_/Dance+Wave%21","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"5","playcount":"69","artist":{"name":"Dance Wave!","url":"https://www.last.fm/music/Dance+Wave%21"},"userplaycount":"1","userloved":"0","toptags":""}} Sep 05 17:45:27 volumio-mac volumio[1419]: info: [LastFM] Updated missing track duration: 0 Sep 05 17:45:29 volumio-mac volumio[1419]: info: Executing endpoint metavolumio Sep 05 17:45:29 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 05 17:45:29 volumio-mac volumio[1419]: info: Executing endpoint metavolumio Sep 05 17:45:29 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 05 17:45:30 volumio-mac volumio[1419]: error: Failed request for metavolumio API Sep 05 17:45:32 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:45:37 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Sep 05 17:45:37 volumio-mac volumio[1419]: info: MRS: Setting this device as single Sep 05 17:45:37 volumio-mac volumio[1419]: info: Sep 05 17:45:37 volumio-mac volumio[1419]: [1757108737197] ---------------------------- Setting Multiroom Single Sep 05 17:45:37 volumio-mac volumio[1419]: info: MRS: disable multiroom output Sep 05 17:45:37 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioDiscard Sep 05 17:45:37 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Sep 05 17:45:37 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 05 17:45:37 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Sep 05 17:45:38 volumio-mac volumio[1419]: info: MRS: STOPPING volumioStreaming Sep 05 17:45:38 volumio-mac sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 05 17:45:38 volumio-mac sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:38 volumio-mac systemd[1]: Stopping VolumioStreamingService... Sep 05 17:45:38 volumio-mac systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Sep 05 17:45:38 volumio-mac systemd[1]: volumioStreaming.service: Succeeded. Sep 05 17:45:38 volumio-mac systemd[1]: Stopped VolumioStreamingService. Sep 05 17:45:38 volumio-mac sudo[1174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream10.ts /tmp/hls/stream6.ts /tmp/hls/stream7.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Sep 05 17:45:38 volumio-mac sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:38 volumio-mac sudo[1171]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:38 volumio-mac sudo[1174]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:38 volumio-mac volumio[1419]: info: MRS: volumioStreaming STOPPED Sep 05 17:45:38 volumio-mac volumio[1419]: info: MRS: Removed streaming files Sep 05 17:45:39 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: Starting browser stream Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: Setting this device as Streaming Server Sep 05 17:45:39 volumio-mac volumio[1419]: info: Sep 05 17:45:39 volumio-mac volumio[1419]: [1757108739285] ---------------------------- MRS: Setting Streaming Server Sep 05 17:45:39 volumio-mac volumio[1419]: info: Enabled audio output: browserPlayback Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: enable multiroom server output Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioMultiRoom Sep 05 17:45:39 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 05 17:45:39 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: STARTING volumioStreaming Sep 05 17:45:39 volumio-mac sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:45:39 volumio-mac sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:39 volumio-mac sudo[1180]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:39 volumio-mac sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Sep 05 17:45:39 volumio-mac sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:39 volumio-mac systemd[1]: Started VolumioStreamingService. Sep 05 17:45:39 volumio-mac sudo[1183]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:39 volumio-mac volumio[1419]: info: MRS: volumioStreaming STARTED Sep 05 17:45:39 volumio-mac sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:45:39 volumio-mac sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:39 volumio-mac sudo[1186]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:47 volumio-mac volumio[1419]: info: CoreCommandRouter::volumioGetState Sep 05 17:45:52 volumio-mac volumio[1419]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: Starting cast device: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 05 17:45:52 volumio-mac volumio[1419]: info: Enabled audio output: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: Setting this device as Streaming Server Sep 05 17:45:52 volumio-mac volumio[1419]: info: Sep 05 17:45:52 volumio-mac volumio[1419]: [1757108752559] ---------------------------- MRS: Setting Streaming Server Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: enable multiroom server output Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioMultiRoom Sep 05 17:45:52 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 05 17:45:52 volumio-mac volumio[1419]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: STARTING volumioStreaming Sep 05 17:45:52 volumio-mac sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream12.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Sep 05 17:45:52 volumio-mac sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:52 volumio-mac sudo[1262]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:52 volumio-mac sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Sep 05 17:45:52 volumio-mac sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:52 volumio-mac systemd[1]: Stopping VolumioStreamingService... Sep 05 17:45:52 volumio-mac systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: Connected to cast device: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 05 17:45:52 volumio-mac systemd[1]: volumioStreaming.service: Succeeded. Sep 05 17:45:52 volumio-mac systemd[1]: Stopped VolumioStreamingService. Sep 05 17:45:52 volumio-mac systemd[1]: Started VolumioStreamingService. Sep 05 17:45:52 volumio-mac sudo[1265]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:52 volumio-mac volumio[1419]: info: MRS: volumioStreaming STARTED Sep 05 17:45:52 volumio-mac sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 05 17:45:52 volumio-mac sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 17:45:52 volumio-mac sudo[1268]: pam_unix(sudo:session): session closed for user root Sep 05 17:45:52 volumio-mac volumio[1419]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 17:45:52 volumio-mac volumio[1419]: TypeError: Cannot read property 'on' of undefined Sep 05 17:45:52 volumio-mac volumio[1419]: at /myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:29834 Sep 05 17:45:52 volumio-mac volumio[1419]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20 Sep 05 17:45:52 volumio-mac volumio[1419]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14 Sep 05 17:45:52 volumio-mac volumio[1419]: at fn.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7) Sep 05 17:45:52 volumio-mac volumio[1419]: at fn.emit (events.js:412:35) Sep 05 17:45:52 volumio-mac volumio[1419]: at Channel.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10) Sep 05 17:45:52 volumio-mac volumio[1419]: at Channel.emit (events.js:400:28) Sep 05 17:45:52 volumio-mac volumio[1419]: at Client.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10) Sep 05 17:45:52 volumio-mac volumio[1419]: at Client.emit (events.js:412:35) Sep 05 17:45:52 volumio-mac volumio[1419]: at PacketStreamWrapper.onpacket (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10) Sep 05 17:45:52 volumio-mac volumio[1419]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 17:45:52 volumio-mac sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-05 17:44 Sep 05 17:45:52 volumio-mac sudo[1280]: 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="95d9088e5dcb3a55aabfe7f209b9ae00946f3ec5" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Aug 2025 06:37:19 PM CEST" VOLUMIO_VERSION="3.839" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="3616d4b5f30ddd7d34bf1bdb3bca86e3"