-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-11-03 10:36:06 CET. -- Nov 03 10:35:06 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Nov 03 10:35:06 motivo volumio[950]: info: handleBrowseUri took 322 milliseconds Nov 03 10:35:06 motivo volumio[950]: info: Preload queue cleared Nov 03 10:35:09 motivo volumio[950]: info: Preload queue cleared Nov 03 10:35:09 motivo volumio[950]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::ClearQueue Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::stop Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::clearPlayQueue Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::saveQueue Nov 03 10:35:09 motivo volumio[950]: info: CoreCommandRouter::volumioPushQueue Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::addQueueItems Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::addQueueItems Nov 03 10:35:09 motivo volumio[950]: info: Preload queue cleared Nov 03 10:35:09 motivo volumio[950]: info: Adding Item to queue: qobuz://album/hgorxaeaqh8mc Nov 03 10:35:09 motivo volumio[950]: info: Exploding uri qobuz://album/hgorxaeaqh8mc in service qobuz Nov 03 10:35:09 motivo volumio[950]: https://prod.vlmapi.io/v2/qobuz/explodeUri Nov 03 10:35:09 motivo volumio[950]: info: explodeUri took 365 milliseconds Nov 03 10:35:09 motivo volumio[950]: info: CoreCommandRouter::volumioPushQueue Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::saveQueue Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::updateTrackBlock Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::getTrackBlock Nov 03 10:35:09 motivo volumio[950]: info: CoreCommandRouter::volumioPlay Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::play index 0 Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::stop Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::play index undefined Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::getTrack 0 Nov 03 10:35:09 motivo volumio[950]: info: CoreStateMachine::startPlaybackTimer Nov 03 10:35:09 motivo volumio[950]: info: CorePlayQueue::getTrack 0 Nov 03 10:35:09 motivo volumio[950]: info: [1762162509730] ControllerQobuz::clearAddPlayTrack Nov 03 10:35:09 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 10:35:09 motivo volumio[950]: info: sendMpdCommand stop took 14 milliseconds Nov 03 10:35:09 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 10:35:09 motivo volumio[950]: info: Nov 03 10:35:09 motivo volumio[950]: ---------------------------- MPD announces system playlist update Nov 03 10:35:09 motivo volumio[950]: info: Ignoring MPD Status Update Nov 03 10:35:09 motivo volumio[950]: info: sendMpdCommand clear took 3 milliseconds Nov 03 10:35:09 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/46456010" Nov 03 10:35:09 motivo volumio[950]: error: updateQueue error: null Nov 03 10:35:09 motivo volumio[950]: info: ------------------------------ 7ms Nov 03 10:35:09 motivo volumio[950]: STREAMING PROXY: Handling url /?data=qobuz://song/46456010 Nov 03 10:35:09 motivo volumio[950]: info: Executing endpoint getStreamUrlqobuz Nov 03 10:35:09 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Nov 03 10:35:10 motivo volumio[950]: info: getStreamUrl took 225 milliseconds Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3673199&eid=46456010&fmt=6&profile=raw&app_id=539451548&cid=3295270&etsp=1762166110&hmac=zL7kVJP2eKpXXYJN9ve9fJusTMg Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Response: 200, length: 25378035 Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Client dropped request, destroying Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/46456010" Nov 03 10:35:10 motivo volumio[950]: info: Nov 03 10:35:10 motivo volumio[950]: ---------------------------- MPD announces system playlist update Nov 03 10:35:10 motivo volumio[950]: info: Ignoring MPD Status Update Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/46456010" took 3 milliseconds Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand play Nov 03 10:35:10 motivo volumio[950]: info: ------------------------------ 7ms Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand play took 5 milliseconds Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Handling url /?data=qobuz://song/46456010 Nov 03 10:35:10 motivo volumio[950]: info: Executing endpoint getStreamUrlqobuz Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Nov 03 10:35:10 motivo volumio[950]: info: getStreamUrl took 199 milliseconds Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3673199&eid=46456010&fmt=6&profile=raw&app_id=539451548&cid=3295270&etsp=1762166110&hmac=zL7kVJP2eKpXXYJN9ve9fJusTMg Nov 03 10:35:10 motivo volumio[950]: STREAMING PROXY: Response: 200, length: 25378035 Nov 03 10:35:10 motivo volumio[950]: info: Nov 03 10:35:10 motivo volumio[950]: ---------------------------- MPD announces state update: player Nov 03 10:35:10 motivo volumio[950]: info: ControllerMpd::getState Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand status Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand status took 24 milliseconds Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::parseState Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 10:35:10 motivo volumio[950]: info: Nov 03 10:35:10 motivo volumio[950]: ---------------------------- MPD announces state update: player Nov 03 10:35:10 motivo volumio[950]: info: ControllerMpd::getState Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand status Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand status took 3 milliseconds Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::parseTrackInfo Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::parseState Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 10:35:10 motivo volumio[950]: info: ControllerMpd::pushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::servicePushState Nov 03 10:35:10 motivo volumio[950]: info: CorePlayQueue::getTrack 0 Nov 03 10:35:10 motivo volumio[950]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"46456010","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/46456010","trackType":"qobuz"} Nov 03 10:35:10 motivo volumio[950]: verbose: CURRENT POSITION 0 Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::syncState stateService play Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::syncState currentStatus stop Nov 03 10:35:10 motivo volumio[950]: info: ------------------------------ 46ms Nov 03 10:35:10 motivo volumio[950]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 03 10:35:10 motivo volumio[950]: verbose: ControllerMpd::parseTrackInfo Nov 03 10:35:10 motivo volumio[950]: info: ControllerMpd::pushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::servicePushState Nov 03 10:35:10 motivo volumio[950]: info: CorePlayQueue::getTrack 0 Nov 03 10:35:10 motivo volumio[950]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"315 Kbps","isStreaming":false,"title":"46456010","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/46456010","trackType":"qobuz"} Nov 03 10:35:10 motivo volumio[950]: verbose: CURRENT POSITION 0 Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::syncState stateService play Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::syncState currentStatus play Nov 03 10:35:10 motivo volumio[950]: info: Received an update from plugin. extracting info from payload Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:10 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:10 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:10 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:10 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:10 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:10 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:10 motivo volumio[950]: info: ------------------------------ 48ms Nov 03 10:35:10 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:10 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:10 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:10 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:10 motivo volumio[950]: info: MCU Signalled Playback Active Nov 03 10:35:11 motivo systemd[1]: Starting Cleanup of Temporary Directories... Nov 03 10:35:11 motivo volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 10:35:11 motivo systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Nov 03 10:35:11 motivo systemd[1]: Started Cleanup of Temporary Directories. Nov 03 10:35:18 motivo volumio[950]: STREAMING PROXY: Client dropped request, destroying Nov 03 10:35:23 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Nov 03 10:35:23 motivo volumio[950]: info: MRS: Setting this device as single Nov 03 10:35:23 motivo volumio[950]: info: Nov 03 10:35:23 motivo volumio[950]: [1762162523844] ---------------------------- Setting Multiroom Single Nov 03 10:35:23 motivo volumio[950]: info: MRS: disable multiroom output Nov 03 10:35:23 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioDiscard Nov 03 10:35:23 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Nov 03 10:35:24 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Nov 03 10:35:24 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Nov 03 10:35:25 motivo volumio[950]: info: MRS: STOPPING volumioStreaming Nov 03 10:35:25 motivo sudo[5326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Nov 03 10:35:25 motivo sudo[5328]: 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 Nov 03 10:35:25 motivo sudo[5328]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:35:25 motivo sudo[5326]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:35:25 motivo sudo[5328]: pam_unix(sudo:session): session closed for user root Nov 03 10:35:25 motivo volumio[950]: info: MRS: Removed streaming files Nov 03 10:35:25 motivo systemd[1]: Stopping VolumioStreamingService... Nov 03 10:35:25 motivo systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Nov 03 10:35:25 motivo systemd[1]: volumioStreaming.service: Succeeded. Nov 03 10:35:25 motivo systemd[1]: Stopped VolumioStreamingService. Nov 03 10:35:25 motivo volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 10:35:25 motivo sudo[5326]: pam_unix(sudo:session): session closed for user root Nov 03 10:35:25 motivo volumio[950]: info: MRS: volumioStreaming STOPPED Nov 03 10:35:38 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:38 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:38 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:38 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:38 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:38 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:38 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:38 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:39 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:39 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:39 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:39 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:39 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:39 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:39 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:39 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:39 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:39 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:39 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:40 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:40 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:40 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:40 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:40 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:41 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:41 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:41 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:41 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:41 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:41 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:41 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:41 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:41 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:41 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:41 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:41 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:41 motivo volumio[950]: info: CoreStateMachine::pushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioPushState Nov 03 10:35:41 motivo volumio[950]: info: CoreCommandRouter::volumioGetState Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output update for this device Nov 03 10:35:41 motivo volumio[950]: info: MRS: Pushing multiroomSync output Nov 03 10:35:41 motivo volumio[950]: info: Signalling Playback active due to playback status change Nov 03 10:35:41 motivo volumio[950]: info: Updating RAAT Signal Path Nov 03 10:35:58 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Nov 03 10:35:58 motivo volumio[950]: info: MRS: Starting browser stream Nov 03 10:35:58 motivo volumio[950]: info: MRS: Setting this device as Streaming Server Nov 03 10:35:58 motivo volumio[950]: info: Nov 03 10:35:58 motivo volumio[950]: [1762162558300] ---------------------------- MRS: Setting Streaming Server Nov 03 10:35:58 motivo volumio[950]: info: Enabled audio output: browserPlayback Nov 03 10:35:58 motivo volumio[950]: info: MRS: enable multiroom server output Nov 03 10:35:58 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioMultiRoom Nov 03 10:35:58 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Nov 03 10:35:58 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Nov 03 10:35:58 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Nov 03 10:35:58 motivo volumio[950]: info: MRS: STARTING volumioStreaming Nov 03 10:35:58 motivo sudo[5383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Nov 03 10:35:58 motivo sudo[5383]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:35:58 motivo sudo[5383]: pam_unix(sudo:session): session closed for user root Nov 03 10:35:58 motivo sudo[5386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Nov 03 10:35:58 motivo sudo[5386]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:35:58 motivo systemd[1]: Started VolumioStreamingService. Nov 03 10:35:58 motivo sudo[5386]: pam_unix(sudo:session): session closed for user root Nov 03 10:35:58 motivo volumio[950]: info: MRS: volumioStreaming STARTED Nov 03 10:35:58 motivo sudo[5394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Nov 03 10:35:58 motivo sudo[5394]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:35:58 motivo sudo[5394]: pam_unix(sudo:session): session closed for user root Nov 03 10:36:05 motivo volumio[950]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Nov 03 10:36:05 motivo volumio[950]: info: MRS: Starting cast device: LS60-Wireless-7b3846501cc750d90b6396d8c0d59903 Nov 03 10:36:05 motivo volumio[950]: info: Enabled audio output: LS60-Wireless-7b3846501cc750d90b6396d8c0d59903 Nov 03 10:36:05 motivo volumio[950]: info: MRS: Setting this device as Streaming Server Nov 03 10:36:05 motivo volumio[950]: info: Nov 03 10:36:05 motivo volumio[950]: [1762162565736] ---------------------------- MRS: Setting Streaming Server Nov 03 10:36:05 motivo volumio[950]: info: MRS: enable multiroom server output Nov 03 10:36:05 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioMultiRoom Nov 03 10:36:05 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Nov 03 10:36:05 motivo volumio[950]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Nov 03 10:36:05 motivo volumio[950]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Nov 03 10:36:05 motivo volumio[950]: info: MRS: STARTING volumioStreaming Nov 03 10:36:05 motivo sudo[5424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream2.ts /tmp/hls/stream3.ts /tmp/hls/stream4.ts /tmp/hls/stream5.ts /tmp/hls/stream6.ts Nov 03 10:36:05 motivo sudo[5424]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:36:05 motivo sudo[5424]: pam_unix(sudo:session): session closed for user root Nov 03 10:36:05 motivo sudo[5426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Nov 03 10:36:05 motivo sudo[5426]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:36:05 motivo systemd[1]: Stopping VolumioStreamingService... Nov 03 10:36:05 motivo volumio[950]: info: MRS: Connected to cast device: LS60-Wireless-7b3846501cc750d90b6396d8c0d59903 Nov 03 10:36:05 motivo systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Nov 03 10:36:05 motivo volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 10:36:05 motivo systemd[1]: volumioStreaming.service: Succeeded. Nov 03 10:36:05 motivo systemd[1]: Stopped VolumioStreamingService. Nov 03 10:36:05 motivo volumio[950]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 10:36:05 motivo systemd[1]: Started VolumioStreamingService. Nov 03 10:36:05 motivo sudo[5426]: pam_unix(sudo:session): session closed for user root Nov 03 10:36:05 motivo volumio[950]: info: MRS: volumioStreaming STARTED Nov 03 10:36:05 motivo sudo[5430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Nov 03 10:36:05 motivo sudo[5430]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 10:36:05 motivo sudo[5430]: pam_unix(sudo:session): session closed for user root Nov 03 10:36:06 motivo volumio[950]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 10:36:06 motivo volumio[950]: TypeError: Cannot read property 'on' of undefined Nov 03 10:36:06 motivo volumio[950]: at /volumio/app/plugins/audio_interface/multiroom/multiroom_real:1:29834 Nov 03 10:36:06 motivo volumio[950]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20 Nov 03 10:36:06 motivo volumio[950]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14 Nov 03 10:36:06 motivo volumio[950]: at fn.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7) Nov 03 10:36:06 motivo volumio[950]: at fn.emit (events.js:327:22) Nov 03 10:36:06 motivo volumio[950]: at Channel.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10) Nov 03 10:36:06 motivo volumio[950]: at Channel.emit (events.js:315:20) Nov 03 10:36:06 motivo volumio[950]: at Client.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10) Nov 03 10:36:06 motivo volumio[950]: at Client.emit (events.js:327:22) Nov 03 10:36:06 motivo volumio[950]: at PacketStreamWrapper.onpacket (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10) Nov 03 10:36:06 motivo volumio[950]: at PacketStreamWrapper.emit (events.js:315:20) Nov 03 10:36:06 motivo volumio[950]: at TLSSocket. (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/packet-stream-wrapper.js:28:16) Nov 03 10:36:06 motivo volumio[950]: at TLSSocket.emit (events.js:315:20) Nov 03 10:36:06 motivo volumio[950]: at emitReadable_ (internal/streams/readable.js:569:12) Nov 03 10:36:06 motivo volumio[950]: at processTicksAndRejections (internal/process/task_queues.js:79:21) Nov 03 10:36:06 motivo volumio[950]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 10:36:06 motivo sudo[5446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 10:35 Nov 03 10:36:06 motivo sudo[5446]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 12:42:34 PM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="03b8c851b751de445da30842a70a04d1"