-- Logs begin at Tue 2026-03-24 18:38:28 KST, end at Tue 2026-03-24 18:46:00 KST. -- Mar 24 18:45:01 volumiotantal volumio[1103]: Searching all installed plugins Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: , search Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Mar 24 18:45:01 volumiotantal volumio[1103]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: webradio , search Mar 24 18:45:01 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 24 18:45:02 volumiotantal volumio[1103]: Searching all installed plugins Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: , search Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Mar 24 18:45:02 volumiotantal volumio[1103]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: webradio , search Mar 24 18:45:02 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 24 18:45:03 volumiotantal volumio[1103]: info: VolumeController::SetAlsaVolume49 Mar 24 18:45:03 volumiotantal volumio[1103]: info: CoreStateMachine::pushState Mar 24 18:45:03 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 0 Mar 24 18:45:03 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 18:45:03 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushState Mar 24 18:45:03 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output update for this device Mar 24 18:45:03 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output Mar 24 18:45:03 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetState Mar 24 18:45:03 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 0 Mar 24 18:45:04 volumiotantal volumio[1103]: info: searchQOBUZUri took 2926 milliseconds Mar 24 18:45:04 volumiotantal volumio[1103]: info: All search sources collected, pushing search results Mar 24 18:45:04 volumiotantal volumio[1103]: info: searchQOBUZUri took 2004 milliseconds Mar 24 18:45:04 volumiotantal volumio[1103]: info: All search sources collected, pushing search results Mar 24 18:45:09 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: handleBrowseUri took 1051 milliseconds Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preload queue cleared Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146173 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146174 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146175 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146176 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146177 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146178 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146179 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146180 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Preloading song: qobuz://song/376146181 Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146173 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146174 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146175 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint getSimilarAlbums Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint getSimilarAlbums Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146176 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint metavolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint metavolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint metavolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: Executing endpoint metavolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146177 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146178 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146179 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146180 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:10 volumiotantal volumio[1103]: info: Exploding uri qobuz://song/376146181 in service qobuz Mar 24 18:45:10 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 977 milliseconds Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 1080 milliseconds Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 1093 milliseconds Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 1081 milliseconds Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 1090 milliseconds Mar 24 18:45:11 volumiotantal volumio[1103]: info: explodeUri took 1043 milliseconds Mar 24 18:45:12 volumiotantal volumio[1103]: info: explodeUri took 1107 milliseconds Mar 24 18:45:12 volumiotantal volumio[1103]: info: explodeUri took 1158 milliseconds Mar 24 18:45:12 volumiotantal volumio[1103]: info: explodeUri took 1060 milliseconds Mar 24 18:45:17 volumiotantal volumio[1103]: info: Preload queue cleared Mar 24 18:45:17 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioAddQueueItems Mar 24 18:45:17 volumiotantal volumio[1103]: info: CoreStateMachine::addQueueItems Mar 24 18:45:17 volumiotantal volumio[1103]: info: CorePlayQueue::addQueueItems Mar 24 18:45:17 volumiotantal volumio[1103]: info: Preload queue cleared Mar 24 18:45:17 volumiotantal volumio[1103]: info: Adding Item to queue: qobuz://album/kupnot3n20i7s Mar 24 18:45:17 volumiotantal volumio[1103]: info: Exploding uri qobuz://album/kupnot3n20i7s in service qobuz Mar 24 18:45:17 volumiotantal volumio[1103]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 24 18:45:18 volumiotantal volumio[1103]: info: explodeUri took 969 milliseconds Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushQueue Mar 24 18:45:18 volumiotantal volumio[1103]: info: CorePlayQueue::saveQueue Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::updateTrackBlock Mar 24 18:45:18 volumiotantal volumio[1103]: info: CorePlayQueue::getTrackBlock Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPlay Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::play index 547 Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::stop Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::play index undefined Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 18:45:18 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 547 Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreStateMachine::startPlaybackTimer Mar 24 18:45:18 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 547 Mar 24 18:45:18 volumiotantal volumio[1103]: info: [1774345518350] ControllerQobuz::clearAddPlayTrack Mar 24 18:45:18 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 18:45:18 volumiotantal volumio[1103]: info: sendMpdCommand stop took 18 milliseconds Mar 24 18:45:18 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 18:45:18 volumiotantal volumio[1103]: info: Mar 24 18:45:18 volumiotantal volumio[1103]: ---------------------------- MPD announces system playlist update Mar 24 18:45:18 volumiotantal volumio[1103]: info: Ignoring MPD Status Update Mar 24 18:45:18 volumiotantal volumio[1103]: info: sendMpdCommand clear took 1 milliseconds Mar 24 18:45:18 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/376146173" Mar 24 18:45:18 volumiotantal volumio[1103]: error: updateQueue error: null Mar 24 18:45:18 volumiotantal volumio[1103]: info: ------------------------------ 1ms Mar 24 18:45:18 volumiotantal volumio[1103]: STREAMING PROXY: Handling url /?data=qobuz://song/376146173 Mar 24 18:45:18 volumiotantal volumio[1103]: info: Executing endpoint getStreamUrlqobuz Mar 24 18:45:18 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 24 18:45:19 volumiotantal volumio[1103]: info: getStreamUrl took 981 milliseconds Mar 24 18:45:19 volumiotantal volumio[1103]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1677507&eid=376146173&fmt=6&profile=raw&app_id=539451548&cid=1474666&etsp=1774349119&hmac=ZyklZ3ViBW0107bynxrLhkbGWZo Mar 24 18:45:19 volumiotantal volumio[1103]: STREAMING PROXY: Requesting upstream with range: none Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Upstream status code: 200 Mar 24 18:45:20 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376146173" Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Client closed connection Mar 24 18:45:20 volumiotantal volumio[1103]: info: Mar 24 18:45:20 volumiotantal volumio[1103]: ---------------------------- MPD announces system playlist update Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Upstream closed. Received 17705 bytes Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Incomplete transfer. Expected 52769124, got 17705 Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Retrying with range: bytes=17705- (attempt 1) Mar 24 18:45:20 volumiotantal volumio[1103]: info: Ignoring MPD Status Update Mar 24 18:45:20 volumiotantal volumio[1103]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376146173" took 1 milliseconds Mar 24 18:45:20 volumiotantal volumio[1103]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 18:45:20 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand play Mar 24 18:45:20 volumiotantal volumio[1103]: info: ------------------------------ 1ms Mar 24 18:45:20 volumiotantal volumio[1103]: info: sendMpdCommand play took 1 milliseconds Mar 24 18:45:20 volumiotantal volumio[1103]: STREAMING PROXY: Handling url /?data=qobuz://song/376146173 Mar 24 18:45:20 volumiotantal volumio[1103]: info: Executing endpoint getStreamUrlqobuz Mar 24 18:45:20 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 24 18:45:21 volumiotantal volumio[1103]: info: getStreamUrl took 901 milliseconds Mar 24 18:45:21 volumiotantal volumio[1103]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1677507&eid=376146173&fmt=6&profile=raw&app_id=539451548&cid=1474666&etsp=1774349120&hmac=zmlM-v1SY21JqHnPCa_bztpBEIg Mar 24 18:45:21 volumiotantal volumio[1103]: STREAMING PROXY: Requesting upstream with range: none Mar 24 18:45:21 volumiotantal volumio[1103]: STREAMING PROXY: Resuming with range: bytes=17705- Mar 24 18:45:21 volumiotantal volumio[1103]: STREAMING PROXY: Upstream status code: 200 Mar 24 18:45:21 volumiotantal volumio[1103]: info: Mar 24 18:45:21 volumiotantal volumio[1103]: ---------------------------- MPD announces state update: player Mar 24 18:45:21 volumiotantal volumio[1103]: info: ControllerMpd::getState Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand status Mar 24 18:45:21 volumiotantal volumio[1103]: info: Mar 24 18:45:21 volumiotantal volumio[1103]: ---------------------------- MPD announces state update: player Mar 24 18:45:21 volumiotantal volumio[1103]: info: sendMpdCommand status took 66 milliseconds Mar 24 18:45:21 volumiotantal volumio[1103]: info: ControllerMpd::getState Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand status Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::parseState Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 18:45:21 volumiotantal volumio[1103]: info: sendMpdCommand status took 1 milliseconds Mar 24 18:45:21 volumiotantal volumio[1103]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::parseState Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::parseTrackInfo Mar 24 18:45:21 volumiotantal volumio[1103]: info: ControllerMpd::pushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::servicePushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 547 Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":461,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376146173","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376146173","trackType":"qobuz"} Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: CURRENT POSITION 547 Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::syncState stateService play Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::syncState currentStatus stop Mar 24 18:45:21 volumiotantal volumio[1103]: info: ------------------------------ 68ms Mar 24 18:45:21 volumiotantal volumio[1103]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: ControllerMpd::parseTrackInfo Mar 24 18:45:21 volumiotantal volumio[1103]: info: ControllerMpd::pushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::servicePushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CorePlayQueue::getTrack 547 Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":461,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"376146173","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376146173","trackType":"qobuz"} Mar 24 18:45:21 volumiotantal volumio[1103]: verbose: CURRENT POSITION 547 Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::syncState stateService play Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::syncState currentStatus play Mar 24 18:45:21 volumiotantal volumio[1103]: info: Received an update from plugin. extracting info from payload Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::pushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output update for this device Mar 24 18:45:21 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreStateMachine::pushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushState Mar 24 18:45:21 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output update for this device Mar 24 18:45:21 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output Mar 24 18:45:21 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetState Mar 24 18:45:21 volumiotantal volumio[1103]: info: ------------------------------ 18ms Mar 24 18:45:21 volumiotantal volumio[1103]: STREAMING PROXY: Resume upstream status code: 206 Mar 24 18:45:23 volumiotantal volumio[1103]: STREAMING PROXY: Upstream closed. Received 52769124 bytes Mar 24 18:45:23 volumiotantal volumio[1103]: STREAMING PROXY: Client closed connection Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioRandom Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreCommandRouter::writePlayerControls Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreStateMachine::setRandom false Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreStateMachine::pushState Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushState Mar 24 18:45:24 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output update for this device Mar 24 18:45:24 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output Mar 24 18:45:24 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetState Mar 24 18:45:25 volumiotantal volumio[1103]: STREAMING PROXY: Resume ended. Received 52751419 bytes Mar 24 18:45:28 volumiotantal volumio[1103]: info: VolumeController::SetAlsaVolume76 Mar 24 18:45:28 volumiotantal volumio[1103]: info: CoreStateMachine::pushState Mar 24 18:45:28 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 18:45:28 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioPushState Mar 24 18:45:28 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output update for this device Mar 24 18:45:28 volumiotantal volumio[1103]: info: MRS: Pushing multiroomSync output Mar 24 18:45:28 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetState Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: Retrieving Cloud Streaming UI Mar 24 18:45:56 volumiotantal volumio[1103]: info: Getting Tidal Cloud Configuration Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: Getting Qobuz Cloud Configuration Mar 24 18:45:56 volumiotantal volumio[1103]: info: Asking plugin for UI Config Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: Getting Spotify Cloud Configuration Mar 24 18:45:56 volumiotantal volumio[1103]: info: Asking plugin for UI Config Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: Saving Spotify Acccount Mar 24 18:45:56 volumiotantal volumio[1103]: info: Got it Mar 24 18:45:56 volumiotantal volumio[1103]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 24 18:45:56 volumiotantal volumio[1103]: info: Got Tidal Cloud Configuration Mar 24 18:45:56 volumiotantal volumio[1103]: info: Got it Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 18:45:56 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 24 18:45:59 volumiotantal volumio[1103]: info: Disabling MyMusic plugin upnp Mar 24 18:45:59 volumiotantal sudo[2556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 24 18:45:59 volumiotantal sudo[2556]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 18:45:59 volumiotantal systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 24 18:45:59 volumiotantal volumio[1103]: error: Upnp client error: Error: This socket has been ended by the other party Mar 24 18:45:59 volumiotantal volumio[1103]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 24 18:46:00 volumiotantal volumio[1103]: info: Enabling MyMusic plugin upnp Mar 24 18:46:00 volumiotantal volumio[1103]: info: Enabling plugin upnp Mar 24 18:46:00 volumiotantal volumio[1103]: info: Loading plugin "upnp"... Mar 24 18:46:00 volumiotantal volumio[1103]: info: [1774345560007] Starting Upmpd Daemon Mar 24 18:46:00 volumiotantal volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 24 18:46:00 volumiotantal volumio[1103]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 18:46:00 volumiotantal volumio[1103]: Error: listen EADDRINUSE: address already in use :::6599 Mar 24 18:46:00 volumiotantal volumio[1103]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Mar 24 18:46:00 volumiotantal volumio[1103]: at listenInCluster (net.js:1366:12) Mar 24 18:46:00 volumiotantal volumio[1103]: at Server.listen (net.js:1452:7) Mar 24 18:46:00 volumiotantal volumio[1103]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 24 18:46:00 volumiotantal volumio[1103]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 24 18:46:00 volumiotantal volumio[1103]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 24 18:46:00 volumiotantal volumio[1103]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 24 18:46:00 volumiotantal volumio[1103]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Mar 24 18:46:00 volumiotantal volumio[1103]: code: 'EADDRINUSE', Mar 24 18:46:00 volumiotantal volumio[1103]: errno: -98, Mar 24 18:46:00 volumiotantal volumio[1103]: syscall: 'listen', Mar 24 18:46:00 volumiotantal volumio[1103]: address: '::', Mar 24 18:46:00 volumiotantal volumio[1103]: port: 6599 Mar 24 18:46:00 volumiotantal volumio[1103]: } Mar 24 18:46:00 volumiotantal volumio[1103]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 18:46:00 volumiotantal sudo[2567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 18:45 Mar 24 18:46:00 volumiotantal sudo[2567]: 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="49c352e1d55e9b76c3bd7b0e3940507619bf455a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="1d32690fc900ac8c739e7eabd35ed0f570899eb8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 19 Dec 2025 02:07:26 PM CET" VOLUMIO_VERSION="3.887" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8f8c1d964af93dfdda0f02ac4140eec2"