-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2024-10-20 12:16:13 BST. -- Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::stPlaybackTimer Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::servicePause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePause Oct 20 12:15:02 minidsp-shd volumio[631]: info: [1729422902406] ControllerQobuz::pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::pause Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: Oct 20 12:15:02 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand pause took 6 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:02 minidsp-shd volumio[631]: info: Oct 20 12:15:02 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:02 minidsp-shd volumio[631]: info: Oct 20 12:15:02 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand status took 14 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand status took 10 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand status took 5 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":76212,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"893 Kbps","isStreaming":false,"title":"294707544","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/294707544","trackType":"qobuz"} Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: CURRENT POSITION 0 Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState stateService pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState currentStatus pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::stPlaybackTimer Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":76212,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"893 Kbps","isStreaming":false,"title":"294707544","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/294707544","trackType":"qobuz"} Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: CURRENT POSITION 0 Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState stateService pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState currentStatus pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::stPlaybackTimer Oct 20 12:15:02 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":76212,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"893 Kbps","isStreaming":false,"title":"294707544","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/294707544","trackType":"qobuz"} Oct 20 12:15:02 minidsp-shd volumio[631]: verbose: CURRENT POSITION 0 Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState stateService pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::syncState currentStatus pause Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:02 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:02 minidsp-shd volumio[631]: info: CoreStateMachine::stPlaybackTimer Oct 20 12:15:02 minidsp-shd volumio[631]: info: ------------------------------ 142ms Oct 20 12:15:02 minidsp-shd volumio[631]: info: ------------------------------ 136ms Oct 20 12:15:02 minidsp-shd volumio[631]: info: ------------------------------ 133ms Oct 20 12:15:02 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:02 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:02 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:05 minidsp-shd volumio[631]: info: MRS: STARTING volumioStreaming Oct 20 12:15:05 minidsp-shd sudo[2061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream12.ts /tmp/hls/stream13.ts /tmp/hls/stream14.ts /tmp/hls/stream15.ts /tmp/hls/stream16.ts /tmp/hls/stream17.ts /tmp/hls/stream18.ts /tmp/hls/stream19.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream21.ts /tmp/hls/stream22.ts /tmp/hls/stream23.ts /tmp/hls/stream24.ts /tmp/hls/stream25.ts /tmp/hls/stream26.ts /tmp/hls/stream27.ts /tmp/hls/stream28.ts /tmp/hls/stream29.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream31.ts /tmp/hls/stream32.ts /tmp/hls/stream33.ts /tmp/hls/stream34.ts /tmp/hls/stream35.ts /tmp/hls/stream36.ts /tmp/hls/stream37.ts /tmp/hls/stream38.ts /tmp/hls/stream39.ts /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream41.ts /tmp/hls/stream42.ts /tmp/hls/stream43.ts /tmp/hls/stream44.ts /tmp/hls/stream45.ts Oct 20 12:15:05 minidsp-shd sudo[2061]: volumio : (command continued) /tmp/hls/stream46.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream6.ts /tmp/hls/stream7.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Oct 20 12:15:05 minidsp-shd sudo[2061]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 12:15:05 minidsp-shd sudo[2061]: pam_unix(sudo:session): session closed for user root Oct 20 12:15:05 minidsp-shd sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Oct 20 12:15:05 minidsp-shd sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 12:15:05 minidsp-shd systemd[1]: Stopping VolumioStreamingService... Oct 20 12:15:05 minidsp-shd systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Oct 20 12:15:05 minidsp-shd volumio[631]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 20 12:15:05 minidsp-shd systemd[1]: volumioStreaming.service: Succeeded. Oct 20 12:15:05 minidsp-shd systemd[1]: Stopped VolumioStreamingService. Oct 20 12:15:05 minidsp-shd volumio[631]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 20 12:15:05 minidsp-shd systemd[1]: Started VolumioStreamingService. Oct 20 12:15:05 minidsp-shd sudo[2064]: pam_unix(sudo:session): session closed for user root Oct 20 12:15:05 minidsp-shd volumio[631]: info: MRS: volumioStreaming STARTED Oct 20 12:15:05 minidsp-shd sudo[2068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 20 12:15:05 minidsp-shd sudo[2068]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 12:15:05 minidsp-shd sudo[2068]: pam_unix(sudo:session): session closed for user root Oct 20 12:15:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 20 12:15:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 20 12:15:10 minidsp-shd volumio[631]: info: Discovery: Getting this device information Oct 20 12:15:10 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioGetState Oct 20 12:15:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 20 12:15:20 minidsp-shd volumio[631]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 20 12:15:20 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 20 12:15:20 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 20 12:15:20 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 20 12:15:20 minidsp-shd volumio[631]: info: Received Get System Version Oct 20 12:15:20 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 20 12:15:25 minidsp-shd volumio-remote-updater[473]: No test mode Oct 20 12:15:25 minidsp-shd volumio-remote-updater[473]: No alpha test mode Oct 20 12:15:25 minidsp-shd volumio[631]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 20 12:15:25 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 20 12:15:26 minidsp-shd volumio[631]: info: CoreCommandRouter::Close All Modals sent Oct 20 12:15:40 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 20 12:15:40 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 20 12:15:40 minidsp-shd volumio[631]: info: Discovery: Getting this device information Oct 20 12:15:40 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioGetState Oct 20 12:15:40 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 20 12:15:47 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Oct 20 12:15:48 minidsp-shd volumio[631]: info: Preload queue cleared Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 20 12:15:49 minidsp-shd volumio[631]: Cannot find translation for source YouTube Music Oct 20 12:15:49 minidsp-shd volumio[631]: Cannot find translation for source Presets Oct 20 12:15:49 minidsp-shd volumio[631]: Cannot find translation for source QOBUZ Oct 20 12:15:49 minidsp-shd volumio[631]: Cannot find translation for source Spotify Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioStop Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::stop Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::updateTrackBlock Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrackBlock Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::stPlaybackTimer Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::serviceStop Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::serviceStop Oct 20 12:15:49 minidsp-shd volumio[631]: info: [1729422949607] ControllerQobuz::stop Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::stop Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand stop Oct 20 12:15:49 minidsp-shd volumio[631]: info: Notifying Active Input {"trackType":"input","service":"inputs","title":"RCA","disableUiControls":true,"albumart":"/albumart"} Oct 20 12:15:49 minidsp-shd volumio[631]: info: Preload queue cleared Oct 20 12:15:49 minidsp-shd volumio[631]: info: Oct 20 12:15:49 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand stop took 60 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 20 12:15:49 minidsp-shd volumio[631]: info: Oct 20 12:15:49 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:49 minidsp-shd volumio[631]: info: Oct 20 12:15:49 minidsp-shd volumio[631]: ---------------------------- MPD announces state update: player Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::getState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand status Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand status took 32 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand status took 25 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand status took 21 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseState Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:49 minidsp-shd volumio[631]: verbose: ControllerMpd::parseTrackInfo Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:49 minidsp-shd volumio[631]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:49 minidsp-shd volumio[631]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Oct 20 12:15:49 minidsp-shd volumio[631]: info: ControllerMpd::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:49 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:49 minidsp-shd volumio[631]: info: CorePlayQueue::getTrack 0 Oct 20 12:15:49 minidsp-shd volumio[631]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Oct 20 12:15:49 minidsp-shd volumio[631]: info: ------------------------------ 137ms Oct 20 12:15:49 minidsp-shd volumio[631]: info: ------------------------------ 130ms Oct 20 12:15:49 minidsp-shd volumio[631]: info: ------------------------------ 126ms Oct 20 12:15:49 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:49 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:49 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:49 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:50 minidsp-shd volumio[631]: info: CoreCommandRouter::servicePushState Oct 20 12:15:50 minidsp-shd volumio[631]: info: CoreStateMachine::pushState Oct 20 12:15:50 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioPushState Oct 20 12:15:50 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output update for this device Oct 20 12:15:50 minidsp-shd volumio[631]: info: MRS: Pushing multiroomSync output Oct 20 12:15:50 minidsp-shd volumio[631]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Oct 20 12:15:51 minidsp-shd volumio[631]: info: MRS: Starting sonos device: uuid:RINCON_7828CAC67AD201400 Oct 20 12:15:51 minidsp-shd volumio[631]: info: Refreshing Cached IP Addresses Oct 20 12:15:51 minidsp-shd sudo[2115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 20 12:15:51 minidsp-shd sudo[2115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 12:15:51 minidsp-shd sudo[2115]: pam_unix(sudo:session): session closed for user root Oct 20 12:15:51 minidsp-shd sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 20 12:15:51 minidsp-shd sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 20 12:15:51 minidsp-shd volumio[631]: error: MRS: Error starting sonos device: uuid:RINCON_7828CAC67AD201400:Error: upnp: statusCode 500 & upnpErrorCode s:ClientUPnPError800 Oct 20 12:15:51 minidsp-shd sudo[2118]: pam_unix(sudo:session): session closed for user root Oct 20 12:16:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 20 12:16:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 20 12:16:10 minidsp-shd volumio[631]: info: Discovery: Getting this device information Oct 20 12:16:10 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioGetState Oct 20 12:16:10 minidsp-shd volumio[631]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 20 12:16:12 minidsp-shd volumio[631]: info: CoreCommandRouter::volumioSeek Oct 20 12:16:12 minidsp-shd volumio[631]: info: CoreStateMachine::seek Oct 20 12:16:12 minidsp-shd volumio[631]: info: [1729422972051] inputs::seek to 0 Oct 20 12:16:12 minidsp-shd volumio[631]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 12:16:12 minidsp-shd volumio[631]: TypeError: this.sendSpopCommand is not a function Oct 20 12:16:12 minidsp-shd volumio[631]: at inputs.seek (/volumio/app/plugins/music_service/inputs/inputs_real:1:2486) Oct 20 12:16:12 minidsp-shd volumio[631]: at CoreStateMachine.seek (/volumio/app/statemachine.js:1084:20) Oct 20 12:16:12 minidsp-shd volumio[631]: at CoreCommandRouter.volumioSeek (/volumio/app/index.js:1421:28) Oct 20 12:16:12 minidsp-shd volumio[631]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:153:33) Oct 20 12:16:12 minidsp-shd volumio[631]: at Socket.emit (events.js:400:28) Oct 20 12:16:12 minidsp-shd volumio[631]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 20 12:16:12 minidsp-shd volumio[631]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 20 12:16:12 minidsp-shd volumio[631]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 20 12:16:13 minidsp-shd sudo[2132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-20 12:15 Oct 20 12:16:13 minidsp-shd sudo[2132]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"