-- Logs begin at Tue 2025-09-02 13:03:34 EDT, end at Thu 2025-09-04 11:44:44 EDT. -- Sep 04 11:43:00 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:43:00 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 23 Sep 04 11:43:07 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:07 volumio-mac volumio[1511]: info: CURURI: music-library Sep 04 11:43:07 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:08 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:43:08 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 23 Sep 04 11:43:11 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:11 volumio-mac volumio[1511]: info: CURURI: music-library/USB Sep 04 11:43:11 volumio-mac volumio[1511]: error: Failed LSINFO: null Sep 04 11:43:11 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:18 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:18 volumio-mac volumio[1511]: info: CURURI: music-library/volumioHD Sep 04 11:43:18 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:22 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:22 volumio-mac volumio[1511]: info: CURURI: music-library Sep 04 11:43:22 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:23 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:43:23 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 23 Sep 04 11:43:28 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:28 volumio-mac volumio[1511]: info: CURURI: music-library/NAS Sep 04 11:43:28 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:31 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 11:43:31 volumio-mac volumio[1511]: info: CURURI: music-library/NAS/happyshowNAS Sep 04 11:43:31 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:38 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:43:38 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 23 Sep 04 11:43:48 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 04 11:43:48 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:43:53 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:43:53 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 23 Sep 04 11:43:58 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 04 11:43:58 volumio-mac volumio[1511]: info: Getting webradio selection Sep 04 11:43:59 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:44:02 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::ClearQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::stop Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::clearPlayQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::saveQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::addQueueItems Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::addQueueItems Sep 04 11:44:02 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:44:02 volumio-mac volumio[1511]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3 Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::saveQueue Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::updateTrackBlock Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::getTrackBlock Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPlay Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::play index 0 Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::stop Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::play index undefined Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreStateMachine::startPlaybackTimer Sep 04 11:44:02 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 11:44:02 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 04 11:44:02 volumio-mac volumio[1511]: info: [1757000642430] ControllerWebradio::clearAddPlayTrack Sep 04 11:44:02 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 11:44:02 volumio-mac volumio[1511]: info: sendMpdCommand stop took 4 milliseconds Sep 04 11:44:02 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 11:44:02 volumio-mac volumio[1511]: info: Sep 04 11:44:02 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:02 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:02 volumio-mac volumio[1511]: info: sendMpdCommand clear took 1 milliseconds Sep 04 11:44:02 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Sep 04 11:44:02 volumio-mac volumio[1511]: error: updateQueue error: null Sep 04 11:44:02 volumio-mac volumio[1511]: info: ------------------------------ 2ms Sep 04 11:44:07 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Sep 04 11:44:07 volumio-mac volumio[1511]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 1 milliseconds Sep 04 11:44:07 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 11:44:07 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand play Sep 04 11:44:07 volumio-mac volumio[1511]: info: Sep 04 11:44:07 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:07 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:07 volumio-mac volumio[1511]: info: sendMpdCommand play took 1 milliseconds Sep 04 11:44:07 volumio-mac volumio[1511]: info: ------------------------------ 0ms Sep 04 11:44:08 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:10 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::ClearQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::stop Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::clearPlayQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::saveQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::addQueueItems Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::addQueueItems Sep 04 11:44:10 volumio-mac volumio[1511]: info: Preload queue cleared Sep 04 11:44:10 volumio-mac volumio[1511]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3 Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::saveQueue Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::updateTrackBlock Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::getTrackBlock Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPlay Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::play index 0 Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::stop Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::play index undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreStateMachine::startPlaybackTimer Sep 04 11:44:10 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 11:44:10 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 04 11:44:10 volumio-mac volumio[1511]: info: [1757000650039] ControllerWebradio::clearAddPlayTrack Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 11:44:10 volumio-mac volumio[1511]: info: Sep 04 11:44:10 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:10 volumio-mac volumio[1511]: info: sendMpdCommand stop took 3 milliseconds Sep 04 11:44:10 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 11:44:10 volumio-mac volumio[1511]: info: Sep 04 11:44:10 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:10 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:10 volumio-mac volumio[1511]: info: sendMpdCommand status took 2 milliseconds Sep 04 11:44:10 volumio-mac volumio[1511]: info: sendMpdCommand clear took 1 milliseconds Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Sep 04 11:44:10 volumio-mac volumio[1511]: error: updateQueue error: null Sep 04 11:44:10 volumio-mac volumio[1511]: info: ------------------------------ 5ms Sep 04 11:44:10 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 11:44:10 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:10 volumio-mac volumio[1511]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 04 11:44:10 volumio-mac volumio[1511]: info: ------------------------------ 7ms Sep 04 11:44:13 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: Starting browser stream Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: Setting this device as Streaming Server Sep 04 11:44:13 volumio-mac volumio[1511]: info: Sep 04 11:44:13 volumio-mac volumio[1511]: [1757000653296] ---------------------------- MRS: Setting Streaming Server Sep 04 11:44:13 volumio-mac volumio[1511]: info: Enabled audio output: browserPlayback Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: enable multiroom server output Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioMultiRoom Sep 04 11:44:13 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 04 11:44:13 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: STARTING volumioStreaming Sep 04 11:44:13 volumio-mac sudo[16793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 04 11:44:13 volumio-mac sudo[16793]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:13 volumio-mac sudo[16793]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:13 volumio-mac sudo[16796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Sep 04 11:44:13 volumio-mac sudo[16796]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:13 volumio-mac systemd[1]: Started VolumioStreamingService. Sep 04 11:44:13 volumio-mac sudo[16796]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:13 volumio-mac volumio[1511]: info: MRS: volumioStreaming STARTED Sep 04 11:44:13 volumio-mac sudo[16799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 04 11:44:13 volumio-mac sudo[16799]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:13 volumio-mac sudo[16799]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:13 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Sep 04 11:44:13 volumio-mac volumio[1511]: info: Sep 04 11:44:13 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:13 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:13 volumio-mac volumio[1511]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 1 milliseconds Sep 04 11:44:13 volumio-mac volumio[1511]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 04 11:44:13 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand play Sep 04 11:44:13 volumio-mac volumio[1511]: info: ------------------------------ 1ms Sep 04 11:44:13 volumio-mac volumio[1511]: info: sendMpdCommand play took 0 milliseconds Sep 04 11:44:14 volumio-mac volumio[1511]: info: Sep 04 11:44:14 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:14 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:14 volumio-mac volumio[1511]: info: Sep 04 11:44:14 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:14 volumio-mac volumio[1511]: info: sendMpdCommand status took 7 milliseconds Sep 04 11:44:14 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:14 volumio-mac volumio[1511]: info: sendMpdCommand status took 1 milliseconds Sep 04 11:44:14 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:14 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus stop Sep 04 11:44:14 volumio-mac volumio[1511]: info: ------------------------------ 9ms Sep 04 11:44:14 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:14 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:14 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:14 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:14 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:14 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:14 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:14 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:14 volumio-mac volumio[1511]: info: ------------------------------ 25ms Sep 04 11:44:14 volumio-mac volumio[1511]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Absolut Radio Sep 04 11:44:14 volumio-mac volumio[1511]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Absolut Radio Sep 04 11:44:14 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:14 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 6ms Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand status took 5 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 1ms Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand status took 4 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Radio AI","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:15 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 16ms Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Radio AI","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:15 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 24ms Sep 04 11:44:15 volumio-mac volumio[1511]: info: [LastFM] Current track has sufficient metadata: title (Absolut Radio AI) and artist (Absolut AI) passed on explicitly Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: error: [LastFM] track info request failed with error: Track not found Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:15 volumio-mac volumio[1511]: info: Sep 04 11:44:15 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 1ms Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand status took 1 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 0 milliseconds Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2734,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Radio AI","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:15 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:15 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:15 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:15 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:15 volumio-mac volumio[1511]: info: ------------------------------ 19ms Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:15 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:17 volumio-mac volumio[1511]: info: Executing endpoint metavolumio Sep 04 11:44:17 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 04 11:44:17 volumio-mac volumio[1511]: info: Executing endpoint metavolumio Sep 04 11:44:17 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 04 11:44:23 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:25 volumio-mac volumio[1511]: info: Executing endpoint metavolumio Sep 04 11:44:25 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 04 11:44:25 volumio-mac volumio[1511]: info: Executing endpoint metavolumio Sep 04 11:44:25 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 04 11:44:28 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Sep 04 11:44:28 volumio-mac volumio[1511]: info: MRS: Starting browser stream Sep 04 11:44:28 volumio-mac volumio[1511]: info: MRS: Setting this device as single Sep 04 11:44:28 volumio-mac volumio[1511]: info: Sep 04 11:44:28 volumio-mac volumio[1511]: [1757000668345] ---------------------------- Setting Multiroom Single Sep 04 11:44:28 volumio-mac volumio[1511]: info: MRS: disable multiroom output Sep 04 11:44:28 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioDiscard Sep 04 11:44:28 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Starting browser stream Sep 04 11:44:29 volumio-mac volumio[1511]: info: Enabled audio output: browserPlayback Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 04 11:44:29 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Sep 04 11:44:29 volumio-mac volumio[1511]: info: Sep 04 11:44:29 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:29 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:29 volumio-mac volumio[1511]: info: Sep 04 11:44:29 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:29 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:29 volumio-mac volumio[1511]: info: ------------------------------ 1ms Sep 04 11:44:29 volumio-mac volumio[1511]: info: sendMpdCommand status took 0 milliseconds Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:29 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:29 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15480,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AVA MAX - EVERYTIME I CRY","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:29 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:29 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:29 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:29 volumio-mac volumio[1511]: info: ------------------------------ 20ms Sep 04 11:44:29 volumio-mac volumio[1511]: info: [LastFM] Split composite title into artist: AVA MAX and title: EVERYTIME I CRY Sep 04 11:44:29 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:29 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: STOPPING volumioStreaming Sep 04 11:44:29 volumio-mac sudo[16850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Sep 04 11:44:29 volumio-mac sudo[16850]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:29 volumio-mac systemd[1]: Stopping VolumioStreamingService... Sep 04 11:44:29 volumio-mac systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Sep 04 11:44:29 volumio-mac systemd[1]: volumioStreaming.service: Succeeded. Sep 04 11:44:29 volumio-mac systemd[1]: Stopped VolumioStreamingService. Sep 04 11:44:29 volumio-mac sudo[16853]: 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/stream13.ts /tmp/hls/stream9.ts Sep 04 11:44:29 volumio-mac sudo[16853]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:29 volumio-mac sudo[16850]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:29 volumio-mac sudo[16853]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: volumioStreaming STOPPED Sep 04 11:44:29 volumio-mac volumio[1511]: info: MRS: Removed streaming files Sep 04 11:44:30 volumio-mac volumio[1511]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"EveryTime I Cry","mbid":"dca3fe54-d058-485d-a1fa-194a9968260a","url":"https://www.last.fm/music/Ava+Max/_/EveryTime+I+Cry","duration":"177000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"117094","playcount":"1272433","artist":{"name":"Ava Max","mbid":"add5f522-25df-41c4-815e-0ca9f60b83e4","url":"https://www.last.fm/music/Ava+Max"},"album":{"artist":"Various Artists","title":"40 Tubes 2022","url":"https://www.last.fm/music/Various+Artists/40+Tubes+2022","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/a1884bf196d209be5afe8dc8cac37272.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/a1884bf196d209be5afe8dc8cac37272.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/a1884bf196d209be5afe8dc8cac37272.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/a1884bf196d209be5afe8dc8cac37272.png","@":{"size":"extralarge"}}]},"userplaycount":"0","userloved":"0","toptags":"","wiki":{"published":"26 Jun 2021, 16:00","summary":"\"EveryTime I Cry\" is a song by American singer Ava Max, released on June 8, 2021, through Atlantic Records. The electropop song was written by Ava Max, Caroline Pennell, Lauren Aquilina, and producers Cirkut and Sean Myer, with lyrics describing the effect of women's empowerment during difficult situations. Read more on Last.fm.","content":"\"EveryTime I Cry\" is a song by American singer Ava Max, released on June 8, 2021, through Atlantic Records. The electropop song was written by Ava Max, Caroline Pennell, Lauren Aquilina, and producers Cirkut and Sean Myer, with lyrics describing the effect of women's empowerment during difficult situations. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} Sep 04 11:44:30 volumio-mac volumio[1511]: info: [LastFM] Updated missing track duration: 177000 Sep 04 11:44:30 volumio-mac volumio[1511]: info: [LastFM] Updated missing track album: 40 Tubes 2022 Sep 04 11:44:32 volumio-mac volumio[1511]: info: Sep 04 11:44:32 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:32 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:32 volumio-mac volumio[1511]: info: Sep 04 11:44:32 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:32 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:32 volumio-mac volumio[1511]: info: ------------------------------ 2ms Sep 04 11:44:32 volumio-mac volumio[1511]: info: sendMpdCommand status took 1 milliseconds Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:32 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:32 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18480,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AVA MAX - EVERYTIME I CRY","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:32 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:32 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:32 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:32 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:32 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:32 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:32 volumio-mac volumio[1511]: info: ------------------------------ 17ms Sep 04 11:44:32 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:32 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:34 volumio-mac volumio[1511]: info: Sep 04 11:44:34 volumio-mac volumio[1511]: ---------------------------- MPD announces system playlist update Sep 04 11:44:34 volumio-mac volumio[1511]: info: Ignoring MPD Status Update Sep 04 11:44:34 volumio-mac volumio[1511]: info: Sep 04 11:44:34 volumio-mac volumio[1511]: ---------------------------- MPD announces state update: player Sep 04 11:44:34 volumio-mac volumio[1511]: info: ControllerMpd::getState Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand status Sep 04 11:44:34 volumio-mac volumio[1511]: info: ------------------------------ 2ms Sep 04 11:44:34 volumio-mac volumio[1511]: info: sendMpdCommand status took 0 milliseconds Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: ControllerMpd::parseState Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 11:44:34 volumio-mac volumio[1511]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: ControllerMpd::parseTrackInfo Sep 04 11:44:34 volumio-mac volumio[1511]: info: ControllerMpd::pushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::servicePushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: CorePlayQueue::getTrack 0 Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20729,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AVA MAX - EVERYTIME I CRY","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Sep 04 11:44:34 volumio-mac volumio[1511]: verbose: CURRENT POSITION 0 Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreStateMachine::syncState stateService play Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreStateMachine::syncState currentStatus play Sep 04 11:44:34 volumio-mac volumio[1511]: info: Received an update from plugin. extracting info from payload Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:34 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:34 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:34 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:34 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:34 volumio-mac volumio[1511]: info: ------------------------------ 16ms Sep 04 11:44:34 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:34 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Sep 04 11:44:37 volumio-mac volumio[1511]: info: VolumeController::SetAlsaVolume100 Sep 04 11:44:37 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:37 volumio-mac volumio[1511]: info: CoreStateMachine::pushState Sep 04 11:44:37 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:44:37 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioPushState Sep 04 11:44:37 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output update for this device Sep 04 11:44:37 volumio-mac volumio[1511]: info: MRS: Pushing multiroomSync output Sep 04 11:44:37 volumio-mac volumio[1511]: info: CoreCommandRouter::volumioGetState Sep 04 11:44:37 volumio-mac volumio[1511]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 11:44:37 volumio-mac volumio[1511]: SPOTIFY: SPOTIFY VOLUME 86 Sep 04 11:44:37 volumio-mac volumio[1511]: SPOTIFY: VOLUMIO VOLUME 100 Sep 04 11:44:37 volumio-mac volumio[1511]: SPOTIFY: DELTA VOLUME ENOUGH: true Sep 04 11:44:37 volumio-mac volumio[1511]: info: Setting Spotify Volume from Volumio: 100 Sep 04 11:44:38 volumio-mac volumio[1511]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Sep 04 11:44:38 volumio-mac volumio[1511]: info: Sending Spotify command with payload to local API: /player/volume Sep 04 11:44:44 volumio-mac volumio[1511]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: Starting cast device: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 04 11:44:44 volumio-mac volumio[1511]: info: Enabled audio output: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: Setting this device as Streaming Server Sep 04 11:44:44 volumio-mac volumio[1511]: info: Sep 04 11:44:44 volumio-mac volumio[1511]: [1757000684116] ---------------------------- MRS: Setting Streaming Server Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: enable multiroom server output Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioMultiRoom Sep 04 11:44:44 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Sep 04 11:44:44 volumio-mac volumio[1511]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: STARTING volumioStreaming Sep 04 11:44:44 volumio-mac sudo[16893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 04 11:44:44 volumio-mac sudo[16893]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:44 volumio-mac sudo[16893]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:44 volumio-mac sudo[16896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Sep 04 11:44:44 volumio-mac sudo[16896]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:44 volumio-mac volumio[1511]: info: MRS: Connected to cast device: Google-Cast-Group-9635258fa0a64322b9033dd23393cb96 Sep 04 11:44:44 volumio-mac volumio[1511]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 11:44:44 volumio-mac volumio[1511]: TypeError: Cannot read property 'on' of undefined Sep 04 11:44:44 volumio-mac volumio[1511]: at /myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:29834 Sep 04 11:44:44 volumio-mac volumio[1511]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20 Sep 04 11:44:44 volumio-mac volumio[1511]: at /myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14 Sep 04 11:44:44 volumio-mac volumio[1511]: at fn.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7) Sep 04 11:44:44 volumio-mac volumio[1511]: at fn.emit (events.js:412:35) Sep 04 11:44:44 volumio-mac volumio[1511]: at Channel.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10) Sep 04 11:44:44 volumio-mac volumio[1511]: at Channel.emit (events.js:400:28) Sep 04 11:44:44 volumio-mac volumio[1511]: at Client.onmessage (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10) Sep 04 11:44:44 volumio-mac volumio[1511]: at Client.emit (events.js:412:35) Sep 04 11:44:44 volumio-mac volumio[1511]: at PacketStreamWrapper.onpacket (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10) Sep 04 11:44:44 volumio-mac volumio[1511]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 11:44:44 volumio-mac systemd[1]: Started VolumioStreamingService. Sep 04 11:44:44 volumio-mac sudo[16896]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:44 volumio-mac sudo[16900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Sep 04 11:44:44 volumio-mac sudo[16900]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:44:44 volumio-mac sudo[16900]: pam_unix(sudo:session): session closed for user root Sep 04 11:44:44 volumio-mac sudo[16911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-04 11:43 Sep 04 11:44:44 volumio-mac sudo[16911]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"