-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2026-01-27 20:10:36 CET. -- Jan 27 20:09:16 volumio-salon volumio[815]: verbose: New Socket.io Connection to 192.168.0.35:3000 from 192.168.0.37 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 27 20:09:16 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 20:09:16 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 20:09:16 volumio-salon volumio[815]: info: Discovery: Getting this device information Jan 27 20:09:16 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:09:16 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPause Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::pause Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::stPlaybackTimer Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::servicePause Jan 27 20:09:23 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::servicePause Jan 27 20:09:23 volumio-salon volumio[815]: info: [1769540963286] ControllerQobuz::pause Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 20:09:23 volumio-salon volumio[815]: info: ControllerMpd::pause Jan 27 20:09:23 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand pause Jan 27 20:09:23 volumio-salon volumio[815]: info: Jan 27 20:09:23 volumio-salon volumio[815]: ---------------------------- MPD announces state update: player Jan 27 20:09:23 volumio-salon volumio[815]: info: sendMpdCommand pause took 3 milliseconds Jan 27 20:09:23 volumio-salon volumio[815]: info: ControllerMpd::getState Jan 27 20:09:23 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand status Jan 27 20:09:23 volumio-salon volumio[815]: info: sendMpdCommand status took 1 milliseconds Jan 27 20:09:23 volumio-salon volumio[815]: verbose: ControllerMpd::parseState Jan 27 20:09:23 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 20:09:23 volumio-salon volumio[815]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 27 20:09:23 volumio-salon volumio[815]: verbose: ControllerMpd::parseTrackInfo Jan 27 20:09:23 volumio-salon volumio[815]: info: ControllerMpd::pushState Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::servicePushState Jan 27 20:09:23 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:09:23 volumio-salon volumio[815]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":197818,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"961 Kbps","isStreaming":false,"title":"716160","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/716160","trackType":"qobuz"} Jan 27 20:09:23 volumio-salon volumio[815]: verbose: CURRENT POSITION 3 Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::syncState stateService pause Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::syncState currentStatus pause Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::pushState Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPushState Jan 27 20:09:23 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output update for this device Jan 27 20:09:23 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:09:23 volumio-salon volumio[815]: info: CoreStateMachine::stPlaybackTimer Jan 27 20:09:23 volumio-salon volumio[815]: info: ------------------------------ 13ms Jan 27 20:09:23 volumio-salon volumio[815]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Jan 27 20:09:36 volumio-salon volumiologrotate[585]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 27 20:09:36 volumio-salon volumiologrotate[585]: ls: cannot access 'SALON': No such file or directory Jan 27 20:09:46 volumio-salon volumio[815]: verbose: New Socket.io Connection to 192.168.0.35:3000 from 192.168.0.37 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 27 20:09:47 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 20:09:47 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 20:09:47 volumio-salon volumio[815]: info: Discovery: Getting this device information Jan 27 20:09:47 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:09:47 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 20:09:56 volumio-salon qobuz-connect[1405]: 20260127 20:09:56.176 [1405.1432] INFO SampleApp: API endpoint invoked: get-connect-info Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1432] INFO SampleApp: API endpoint invoked: connect-to-qconnect Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO EndpointManager: [0x14c5f70]: Updating API endpoint Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO EndpointManager: [0x14c5f70]: Updating QConnect endpoint Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO ActiveStateManager: [0x14c4f88]: Setting new active state: active Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO PlaybackSessionManager: [0x14c6360]: Starting playback session maintenance Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO HttpDownloader: [0x14c6550]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO CloudClient: [0x14c6bd0]: Connecting to the cloud Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.518 [1405.1405] INFO SampleApp: Renderer is now active Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.705 [1405.1405] INFO CloudClient: [0x14c6bd0]: Connection established Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.705 [1405.1405] INFO QwspMessageSender: [0x198af20]: Sending Authenticate message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QwspMessageSender: [0x198af20]: Sending Subscribe message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QConnectMessageSender: [0x198af30]: Sending JoinSession message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QConnectMessageSender: [0x198af30]: Sending VolumeChanged message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QConnectMessageSender: [0x198af30]: Sending VolumeMuted message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QConnectMessageSender: [0x198af30]: Sending MaxAudioQualityChanged message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.706 [1405.1405] INFO QwspMessageSender: [0x198af20]: Sending Payload message Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Received SetActive message: active Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Received SetState message: Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Playing state: Playing Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Playback position: 20541 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Queue version: 48.2 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Current track: TID: 367102510, QID: 1, Context UUID: 43119228-ee6f-4577-acf3-8d57c88f2ee7 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Next track: TID: 367102511, QID: 2, Context UUID: 43119228-ee6f-4577-acf3-8d57c88f2ee7 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO MediaEngine: [0x14c65f8]: Stopping playback, clearing tracks Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO MediaEngine: [0x14c65f8]: Initiating playback Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Received SetLoopMode message: Off Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO PlaybackControlsManager: [0x14c69d0]: Setting new loop mode: Off Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO MediaEngine: [0x14c65f8]: Setting current track: 367102510, initial offset: 20541ms Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Clearing all streams Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: New stream: 109 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO HttpDownloader: [0x155ca30]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=ea032b4d65c9b6f6147a19b848065c69&request_ts=1769541001&track_id=367102510 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO HttpDownloader: [0x155cd78]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=367102510 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 109]: Running audio stream Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Received SetShuffleMode message: disabled Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.746 [1405.1405] INFO PlaybackControlsManager: [0x14c69d0]: Setting new shuffle mode: disabled Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.747 [1405.1405] INFO MediaEngine: [0x14c65f8]: Setting next track: 367102511 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.747 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: New stream: 110 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.747 [1405.1405] INFO HttpDownloader: [0x2b1bc88]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d17a20bf084c82753ea055b01121f961&request_ts=1769541001&track_id=367102511 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.747 [1405.1405] INFO HttpDownloader: [0x1675fb0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=367102511 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.747 [1405.1405] INFO MediaEngine: [0x14c65f8]: Waiting for current stream to start before starting audio renderer Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.771 [1405.1405] INFO PlaybackSessionManager: [0x14c6360]: Playback session has been refreshed Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.771 [1405.1405] INFO HttpDownloader: [0x16c6648]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a123ee8593b97bc6a2b6c341ea546506&request_ts=1769541001&track_id=367102510 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.772 [1405.1405] INFO HttpDownloader: [0x2c9f8e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a828aee2b6bb71256bc2f27fa0779749&request_ts=1769541001&track_id=367102511 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.856 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 110]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=9386984&eid=367102511&fmt=27&profile=raw&app_id=174516466&cid=3616548&etsp=1769544601&hmac=Yf9bBtDHaG-sPtqN-OfhTivc5q8 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.886 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 110]: Metadata became available: Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.886 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Title: Symphony No. 3 in C Minor, Op. 78, R. 176 "Organ": IIa. Allegro moderato - Presto Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.886 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Artist: Yannick Nézet-Séguin Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.886 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Album: Saint-Saëns, Guilmant & Others: Orchestral Works Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.886 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Album art URL: https://static.qobuz.com/images/covers/pa/hh/w1gysvllfhhpa_600.jpg Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.899 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 109]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=9386984&eid=367102510&fmt=27&profile=raw&app_id=174516466&cid=3616548&etsp=1769544601&hmac=blz8VdxddyOuUiVVds8TYhZBt28 Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.913 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 109]: Metadata became available: Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.913 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Title: Symphony No. 3 in C Minor, Op. 78, R. 176 "Organ": Ib. Poco adagio Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.913 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Artist: Yannick Nézet-Séguin Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.913 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Album: Saint-Saëns, Guilmant & Others: Orchestral Works Jan 27 20:10:01 volumio-salon qobuz-connect[1405]: 20260127 20:10:01.913 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: Album art URL: https://static.qobuz.com/images/covers/pa/hh/w1gysvllfhhpa_600.jpg Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 109]: stream information have been fetched Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO UrlAudioSource: [0x155b7c8]: Starting URL audio source, initial position: 20541ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=9386984&eid=367102510&fmt=27&profile=raw&app_id=174516466&cid=3616548&etsp=1769544601&hmac=blz8VdxddyOuUiVVds8TYhZBt28 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO ContentFetcher: [0x155afc8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=9386984&eid=367102510&fmt=27&profile=raw&app_id=174516466&cid=3616548&etsp=1769544601&hmac=blz8VdxddyOuUiVVds8TYhZBt28, offset: 0 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO AudioRenderer: [0x14c6818]: Starting audio renderer, initial playback state: Playing Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO SampleApp: [Stream 109]: New audio stream (starting from 20540ms) Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.408 [1405.1405] INFO SampleApp: [Stream 109]: Stream metadata became available: Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.409 [1405.1405] INFO SampleApp: Title: Symphony No. 3 in C Minor, Op. 78, R. 176 "Organ": Ib. Poco adagio Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.409 [1405.1405] INFO SampleApp: Artist: Yannick Nézet-Séguin Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.409 [1405.1405] INFO SampleApp: Album: Saint-Saëns, Guilmant & Others: Orchestral Works Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.409 [1405.1405] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/pa/hh/w1gysvllfhhpa_600.jpg Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: setActiveState() Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: Set Qobuz connect default volume to 1 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.413 [1405.1405] INFO VolumeManager: [0x14c6a60]: Setting new playback volume: 1 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: Stopping currently active service Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioStop Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::stop Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::updateTrackBlock Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrackBlock Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::stPlaybackTimer Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::pushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPushState Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output update for this device Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::serviceStop Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::serviceStop Jan 27 20:10:02 volumio-salon volumio[815]: info: [1769541002420] ControllerQobuz::stop Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 20:10:02 volumio-salon volumio[815]: info: ControllerMpd::stop Jan 27 20:10:02 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 20:10:02 volumio-salon volumio[815]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Jan 27 20:10:02 volumio-salon volumio[815]: info: Jan 27 20:10:02 volumio-salon volumio[815]: ---------------------------- MPD announces state update: player Jan 27 20:10:02 volumio-salon volumio[815]: info: sendMpdCommand stop took 15 milliseconds Jan 27 20:10:02 volumio-salon volumio[815]: info: ControllerMpd::getState Jan 27 20:10:02 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand status Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::servicePushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::pushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPushState Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output update for this device Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:10:02 volumio-salon volumio[815]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jan 27 20:10:02 volumio-salon volumio[815]: info: sendMpdCommand status took 13 milliseconds Jan 27 20:10:02 volumio-salon volumio[815]: verbose: ControllerMpd::parseState Jan 27 20:10:02 volumio-salon volumio[815]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 20:10:02 volumio-salon volumio[815]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Jan 27 20:10:02 volumio-salon volumio[815]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 27 20:10:02 volumio-salon volumio[815]: verbose: ControllerMpd::parseTrackInfo Jan 27 20:10:02 volumio-salon volumio[815]: info: ControllerMpd::pushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::servicePushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::pushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPushState Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output update for this device Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: CorePlayQueue::getTrack 3 Jan 27 20:10:02 volumio-salon volumio[815]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 20:10:02 volumio-salon volumio[815]: info: ------------------------------ 32ms Jan 27 20:10:02 volumio-salon volumio[815]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.502 [1405.1405] INFO VolumeManager: [0x14c6a60]: Setting new playback volume: 1 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.563 [1405.1405] INFO SampleApp: Playback volume changed: 1 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.563 [1405.1405] INFO ProtocolHandler: [0x14c6d38]: Volume changed: 1 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.563 [1405.1405] INFO QConnectMessageSender: [0x198af30]: Sending VolumeChanged message Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.563 [1405.1405] INFO QwspMessageSender: [0x198af20]: Sending Payload message Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: info: QobuzConnect: Volume received from daemon: 1 Jan 27 20:10:02 volumio-salon volumio[815]: info: VolumeController::SetAlsaVolume1 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.575 [1405.1405] INFO UrlAudioSource: [0x155b7c8]: Content info extracted Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.575 [1405.1405] INFO UrlAudioSource: [0x155b7c8]: Size: 348771270 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Stream info: Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Total samples: 111251952 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Sample rate: 176400 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Channel count: 2 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Bits per sample: 24 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.577 [1405.17190] INFO AudioDecoder: [0x2d79268]: Duration: 630680 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.578 [1405.1405] INFO UrlAudioSource: [0x155b7c8]: Audio properties have changed Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.578 [1405.1405] INFO UrlAudioSource: [0x155b7c8]: Seeking input stream to byte offset: 11146268 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.578 [1405.1405] INFO ContentFetcher: [0x155afc8]: Adjusting download offset to: 11146268 Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreStateMachine::pushState Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioPushState Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output update for this device Jan 27 20:10:02 volumio-salon volumio[815]: info: MRS: Pushing multiroomSync output Jan 27 20:10:02 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:02 volumio-salon volumio[815]: SPOTIFY: RECEIVED VOLUMIO VOLUME 1 Jan 27 20:10:02 volumio-salon volumio[815]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 27 20:10:02 volumio-salon qobuz-connect[1405]: 20260127 20:10:02.778 [1405.1405] INFO AudioStreamManager: [0x14c66e0]: [Stream 110]: stream information have been fetched Jan 27 20:10:17 volumio-salon volumio[815]: verbose: New Socket.io Connection to 192.168.0.35:3000 from 192.168.0.37 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 27 20:10:17 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 20:10:17 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 20:10:17 volumio-salon volumio[815]: info: Discovery: Getting this device information Jan 27 20:10:17 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetState Jan 27 20:10:17 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: Retrieving Cloud Streaming UI Jan 27 20:10:32 volumio-salon volumio[815]: info: Getting Tidal Cloud Configuration Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: Getting Qobuz Cloud Configuration Jan 27 20:10:32 volumio-salon volumio[815]: info: Asking plugin for UI Config Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: Getting Spotify Cloud Configuration Jan 27 20:10:32 volumio-salon volumio[815]: info: Asking plugin for UI Config Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: Saving Spotify Acccount Jan 27 20:10:32 volumio-salon volumio[815]: info: Got it Jan 27 20:10:32 volumio-salon volumio[815]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 27 20:10:32 volumio-salon volumio[815]: info: Got Tidal Cloud Configuration Jan 27 20:10:32 volumio-salon volumio[815]: info: Got it Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 20:10:32 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 27 20:10:35 volumio-salon volumio[815]: info: Disabling MyMusic plugin upnp Jan 27 20:10:35 volumio-salon sudo[17244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jan 27 20:10:35 volumio-salon sudo[17244]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 20:10:35 volumio-salon systemd[1]: Stopping UPnP Renderer front-end to MPD... Jan 27 20:10:35 volumio-salon volumio[815]: error: Upnp client error: Error: This socket has been ended by the other party Jan 27 20:10:35 volumio-salon volumio[815]: info: Enabling MyMusic plugin upnp Jan 27 20:10:35 volumio-salon volumio[815]: info: Enabling plugin upnp Jan 27 20:10:35 volumio-salon volumio[815]: info: Loading plugin "upnp"... Jan 27 20:10:35 volumio-salon volumio[815]: info: [1769541035921] Starting Upmpd Daemon Jan 27 20:10:35 volumio-salon volumio[815]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 27 20:10:35 volumio-salon volumio[815]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 20:10:35 volumio-salon volumio[815]: Error: listen EADDRINUSE: address already in use :::6599 Jan 27 20:10:35 volumio-salon volumio[815]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jan 27 20:10:35 volumio-salon volumio[815]: at listenInCluster (net.js:1366:12) Jan 27 20:10:35 volumio-salon volumio[815]: at Server.listen (net.js:1452:7) Jan 27 20:10:35 volumio-salon volumio[815]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jan 27 20:10:35 volumio-salon volumio[815]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jan 27 20:10:35 volumio-salon volumio[815]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jan 27 20:10:35 volumio-salon volumio[815]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 27 20:10:35 volumio-salon volumio[815]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jan 27 20:10:35 volumio-salon volumio[815]: code: 'EADDRINUSE', Jan 27 20:10:35 volumio-salon volumio[815]: errno: -98, Jan 27 20:10:35 volumio-salon volumio[815]: syscall: 'listen', Jan 27 20:10:35 volumio-salon volumio[815]: address: '::', Jan 27 20:10:35 volumio-salon volumio[815]: port: 6599 Jan 27 20:10:35 volumio-salon volumio[815]: } Jan 27 20:10:35 volumio-salon volumio[815]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 20:10:36 volumio-salon sudo[17255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-27 20:09 Jan 27 20:10:36 volumio-salon sudo[17255]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"