-- Logs begin at Wed 2026-03-18 22:29:01 CDT, end at Wed 2026-03-25 18:36:08 CDT. -- Mar 25 18:35:02 shd-master nmbd[712]: [2026/03/25 18:35:02.880895, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 25 18:35:02 shd-master nmbd[712]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.20 for name WORKGROUP<1d>. Mar 25 18:35:02 shd-master nmbd[712]: This response was from IP 192.168.0.10, reporting an IP address of 192.168.0.10. Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioPlay Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::play index 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::stop Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::stPlaybackTimer Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::updateTrackBlock Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrackBlock Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 4 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 4 Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::serviceStop Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 4 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::serviceStop Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::stop Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 18:35:19 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand stop took 24 milliseconds Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::play index undefined Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::startPlaybackTimer Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 25 18:35:19 shd-master volumio[753]: info: [1774481719189] ControllerQobuz::clearAddPlayTrack Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand status took 13 milliseconds Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand stop took 3 milliseconds Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand clear Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:19 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand clear took 12 milliseconds Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand status took 9 milliseconds Mar 25 18:35:19 shd-master volumio[753]: info: sendMpdCommand status took 6 milliseconds Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::parseTrackInfo Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/390818961" Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:19 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:19 shd-master volumio[753]: STREAMING PROXY: Handling url /?data=qobuz://song/390818961 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Mar 25 18:35:19 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:19 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:19 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:19 shd-master volumio[753]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Mar 25 18:35:19 shd-master volumio[753]: info: ------------------------------ 93ms Mar 25 18:35:19 shd-master volumio[753]: info: ------------------------------ 73ms Mar 25 18:35:19 shd-master volumio[753]: info: ------------------------------ 71ms Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:19 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:19 shd-master volumio[753]: info: Mar 25 18:35:19 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:19 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:19 shd-master volumio[753]: error: updateQueue error: null Mar 25 18:35:19 shd-master volumio[753]: info: ------------------------------ 75ms Mar 25 18:35:19 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:19 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:19 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:19 shd-master volumio[753]: info: Executing endpoint getStreamUrlqobuz Mar 25 18:35:19 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 25 18:35:19 shd-master volumio[753]: info: getStreamUrl took 361 milliseconds Mar 25 18:35:19 shd-master volumio[753]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1020932&eid=390818961&fmt=7&profile=raw&app_id=539451548&cid=2796186&etsp=1774485319&hmac=5kad5miB3WtbB798y1uLzCc2Krc Mar 25 18:35:21 shd-master volumiologrotate[507]: ls: cannot access '/var/log/samba/log.wb-SHD': No such file or directory Mar 25 18:35:21 shd-master volumiologrotate[507]: ls: cannot access 'MASTER': No such file or directory Mar 25 18:35:24 shd-master volumio[753]: STREAMING PROXY: Response: 200, length: 72576135 Mar 25 18:35:24 shd-master volumio[753]: STREAMING PROXY: Client dropped request, destroying Mar 25 18:35:24 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/390818961" Mar 25 18:35:24 shd-master volumio[753]: error: updateQueue error: null Mar 25 18:35:24 shd-master volumio[753]: error: updateQueue error: null Mar 25 18:35:24 shd-master volumio[753]: info: Mar 25 18:35:24 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:24 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:24 shd-master volumio[753]: info: ------------------------------ 5054ms Mar 25 18:35:24 shd-master volumio[753]: info: ------------------------------ 5053ms Mar 25 18:35:24 shd-master volumio[753]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/390818961" took 6 milliseconds Mar 25 18:35:24 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 25 18:35:24 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand play Mar 25 18:35:24 shd-master volumio[753]: Upnp client error: Error: This socket has been ended by the other party Mar 25 18:35:24 shd-master volumio[753]: Upnp client error: Error: This socket has been ended by the other party Mar 25 18:35:24 shd-master volumio[753]: STREAMING PROXY: Handling url /?data=qobuz://song/390818961 Mar 25 18:35:24 shd-master volumio[753]: info: Mar 25 18:35:24 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:24 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:24 shd-master volumio[753]: info: Mar 25 18:35:24 shd-master volumio[753]: ---------------------------- MPD announces system playlist update Mar 25 18:35:24 shd-master volumio[753]: info: Ignoring MPD Status Update Mar 25 18:35:24 shd-master volumio[753]: info: ------------------------------ 17ms Mar 25 18:35:24 shd-master volumio[753]: info: sendMpdCommand play took 14 milliseconds Mar 25 18:35:24 shd-master volumio[753]: info: ------------------------------ 9ms Mar 25 18:35:24 shd-master volumio[753]: info: ------------------------------ 7ms Mar 25 18:35:24 shd-master volumio[753]: info: Executing endpoint getStreamUrlqobuz Mar 25 18:35:24 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 25 18:35:24 shd-master volumio[753]: info: getStreamUrl took 564 milliseconds Mar 25 18:35:24 shd-master volumio[753]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1020932&eid=390818961&fmt=7&profile=raw&app_id=539451548&cid=2796186&etsp=1774485324&hmac=W6PBw3omjOJga-aT32ixbZGVzq4 Mar 25 18:35:27 shd-master volumio[753]: STREAMING PROXY: Error proxying request: Error: socket hang up Mar 25 18:35:27 shd-master volumio[753]: STREAMING PROXY: Client dropped request, destroying Mar 25 18:35:27 shd-master volumio[753]: info: Mar 25 18:35:27 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:27 shd-master volumio[753]: info: Mar 25 18:35:27 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:27 shd-master volumio[753]: info: Mar 25 18:35:27 shd-master volumio[753]: ---------------------------- MPD announces state update: player Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::getState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand status Mar 25 18:35:27 shd-master volumio[753]: error: MPD Playback Error: Failed to decode stream, moving to next track Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand status took 20 milliseconds Mar 25 18:35:27 shd-master volumio[753]: error: MPD Playback Error: Failed to decode stream, moving to next track Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand status took 18 milliseconds Mar 25 18:35:27 shd-master volumio[753]: error: MPD Playback Error: Failed to decode stream, moving to next track Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand status took 18 milliseconds Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseState Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand clearerror took 21 milliseconds Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand clearerror took 19 milliseconds Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand clearerror took 16 milliseconds Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 25 18:35:27 shd-master volumio[753]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseTrackInfo Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseTrackInfo Mar 25 18:35:27 shd-master volumio[753]: verbose: ControllerMpd::parseTrackInfo Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:27 shd-master volumio[753]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"390818961","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/390818961","trackType":"qobuz"} Mar 25 18:35:27 shd-master volumio[753]: verbose: CURRENT POSITION 5 Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState stateService stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState currentStatus stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: No code Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:27 shd-master volumio[753]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"390818961","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/390818961","trackType":"qobuz"} Mar 25 18:35:27 shd-master volumio[753]: verbose: CURRENT POSITION 5 Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState stateService stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState currentStatus stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: No code Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: ControllerMpd::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::servicePushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: CorePlayQueue::getTrack 5 Mar 25 18:35:27 shd-master volumio[753]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"390818961","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/390818961","trackType":"qobuz"} Mar 25 18:35:27 shd-master volumio[753]: verbose: CURRENT POSITION 5 Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState stateService stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::syncState currentStatus stop Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: No code Mar 25 18:35:27 shd-master volumio[753]: info: CoreStateMachine::pushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioPushState Mar 25 18:35:27 shd-master volumio[753]: info: CoreCommandRouter::volumioGetState Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output update for this device Mar 25 18:35:27 shd-master volumio[753]: info: MRS: Pushing multiroomSync output Mar 25 18:35:27 shd-master volumio[753]: info: ------------------------------ 162ms Mar 25 18:35:27 shd-master volumio[753]: info: ------------------------------ 160ms Mar 25 18:35:27 shd-master volumio[753]: info: ------------------------------ 158ms Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:27 shd-master volumio[753]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Mar 25 18:35:28 shd-master volumio[753]: info: Moving to next track after playback error Mar 25 18:35:28 shd-master volumio[753]: info: CoreCommandRouter::volumioPlay Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::play index 6 Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::stop Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::play index undefined Mar 25 18:35:28 shd-master volumio[753]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 18:35:28 shd-master volumio[753]: info: CorePlayQueue::getTrack 6 Mar 25 18:35:34 shd-master volumio[753]: info: CoreCommandRouter::volumioRemoveQueueItem Mar 25 18:35:34 shd-master volumio[753]: info: CoreStateMachine::removeQueueItem Mar 25 18:35:34 shd-master volumio[753]: info: CorePlayQueue::removeQueueItem 5 Mar 25 18:35:34 shd-master volumio[753]: info: CorePlayQueue::saveQueue Mar 25 18:35:34 shd-master volumio[753]: info: CoreCommandRouter::volumioPushQueue Mar 25 18:35:40 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 18:35:40 shd-master volumio[753]: info: CURURI: music-library/USB/Music_Server/Download/Qobuz/Dave Holland Quartet 24 96 Mar 25 18:35:40 shd-master volumio[753]: info: Preload queue cleared Mar 25 18:35:40 shd-master volumio[753]: info: Preloading song: music-library/USB/Music_Server/Download/Qobuz/Dave Holland Quartet 24 96/Dave Holland Quartet Q_A 24-96.wav Mar 25 18:35:40 shd-master volumio[753]: info: Exploding uri music-library/USB/Music_Server/Download/Qobuz/Dave Holland Quartet 24 96/Dave Holland Quartet Q_A 24-96.wav in service mpd Mar 25 18:35:40 shd-master volumio[753]: info: ALBUMART /albumart?cacheid=765&web=Dave%20Holland%20Quartet/Conference%20Of%20The%20Birds/large&path=%2Fmnt%2FUSB%2FMusic_Server%2FDownload%2FQobuz%2FDave%20Holland%20Quartet%2024%2096%2FDave%20Holland%20Quartet%20Q_A%2024-96.wav&metadata=false Mar 25 18:35:40 shd-master volumio[753]: info: URI /mnt/USB/Music_Server/Download/Qobuz/Dave Holland Quartet 24 96/Dave Holland Quartet Q_A 24-96.wav Mar 25 18:35:43 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 25 18:35:44 shd-master volumio[753]: info: handleBrowseUri took 146 milliseconds Mar 25 18:35:44 shd-master volumio[753]: info: Preload queue cleared Mar 25 18:35:44 shd-master volumio[753]: info: Preload queue cleared Mar 25 18:35:49 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:49 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:49 shd-master volumio[753]: info: searchQOBUZUri took 950 milliseconds Mar 25 18:35:49 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:50 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:50 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:51 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:51 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:51 shd-master volumio[753]: info: searchQOBUZUri took 1242 milliseconds Mar 25 18:35:51 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:52 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:52 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:52 shd-master volumio[753]: info: searchQOBUZUri took 1021 milliseconds Mar 25 18:35:52 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:53 shd-master volumio[753]: info: searchQOBUZUri took 1151 milliseconds Mar 25 18:35:53 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:53 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:53 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:54 shd-master volumio[753]: info: searchQOBUZUri took 859 milliseconds Mar 25 18:35:54 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:54 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:54 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:55 shd-master volumio[753]: info: searchQOBUZUri took 830 milliseconds Mar 25 18:35:55 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:55 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:55 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:55 shd-master volumio[753]: Searching plugin music_service/qobuz Mar 25 18:35:55 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 25 18:35:56 shd-master volumio[753]: info: searchQOBUZUri took 850 milliseconds Mar 25 18:35:56 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:57 shd-master volumio[753]: info: searchQOBUZUri took 1135 milliseconds Mar 25 18:35:57 shd-master volumio[753]: info: All search sources collected, pushing search results Mar 25 18:35:57 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 25 18:35:58 shd-master volumio[753]: info: handleBrowseUri took 841 milliseconds Mar 25 18:35:58 shd-master volumio[753]: info: Preload queue cleared Mar 25 18:35:58 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:58 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:35:59 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:35:59 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:00 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:36:00 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:01 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:36:01 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:02 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:36:02 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:02 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:36:02 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:02 shd-master volumio[753]: info: Executing endpoint metavolumio Mar 25 18:36:02 shd-master volumio[753]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 25 18:36:07 shd-master volumio[753]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 18:36:07 shd-master volumio[753]: TypeError: Cannot read property 'slice' of null Mar 25 18:36:07 shd-master volumio[753]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Mar 25 18:36:07 shd-master volumio[753]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Mar 25 18:36:07 shd-master volumio[753]: at Object.onceWrapper (events.js:520:26) Mar 25 18:36:07 shd-master volumio[753]: at ClientRequest.emit (events.js:400:28) Mar 25 18:36:07 shd-master volumio[753]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Mar 25 18:36:07 shd-master volumio[753]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Mar 25 18:36:07 shd-master volumio[753]: at TLSSocket.socketOnData (_http_client.js:515:22) Mar 25 18:36:07 shd-master volumio[753]: at TLSSocket.emit (events.js:400:28) Mar 25 18:36:07 shd-master volumio[753]: at addChunk (internal/streams/readable.js:293:12) Mar 25 18:36:07 shd-master volumio[753]: at readableAddChunk (internal/streams/readable.js:267:9) Mar 25 18:36:07 shd-master volumio[753]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 18:36:08 shd-master sudo[8276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-25 18:35 Mar 25 18:36:08 shd-master sudo[8276]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 18 Nov 2025 04:27:40 PM CET" VOLUMIO_VERSION="3.877" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="861d146b0ca5e28d2e157bf87e6b15ea"