-- Logs begin at Mon 2025-09-15 19:41:36 JST, end at Tue 2025-09-16 20:50:13 JST. -- Sep 16 20:49:00 rivo-aki qobuz-connect[3775]: 20250916 20:49:00.096 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:00 rivo-aki qobuz-connect[3775]: 20250916 20:49:00.096 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:00 rivo-aki qobuz-connect[3775]: 20250916 20:49:00.096 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:00 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:00 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:00 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:01 rivo-aki volumio[3106]: verbose: New Socket.io Connection to 192.168.1.25:3000 from 192.168.1.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Sep 16 20:49:08 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:49:08 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:49:08 rivo-aki volumio[3106]: info: Discovery: Getting this device information Sep 16 20:49:08 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:08 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:49:10 rivo-aki qobuz-connect[3775]: 20250916 20:49:10.097 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:10 rivo-aki qobuz-connect[3775]: 20250916 20:49:10.097 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:10 rivo-aki qobuz-connect[3775]: 20250916 20:49:10.097 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:10 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:10 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:10 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:10 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:15 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:49:15 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:49:15 rivo-aki volumio[3106]: info: Discovery: Getting this device information Sep 16 20:49:15 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:15 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:49:16 rivo-aki volumio[3106]: verbose: New Socket.io Connection to 192.168.1.25:3000 from 192.168.1.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Sep 16 20:49:20 rivo-aki qobuz-connect[3775]: 20250916 20:49:20.097 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:20 rivo-aki qobuz-connect[3775]: 20250916 20:49:20.097 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:20 rivo-aki qobuz-connect[3775]: 20250916 20:49:20.097 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:20 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:20 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:20 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:49:20 rivo-aki volumio[3106]: info: Discovery: Getting this device information Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:20 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:49:23 rivo-aki volumiologrotate[2844]: ls: cannot access '/var/log/samba/log.wb-RIVO': No such file or directory Sep 16 20:49:23 rivo-aki volumiologrotate[2844]: ls: cannot access 'AKI': No such file or directory Sep 16 20:49:29 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:30 rivo-aki qobuz-connect[3775]: 20250916 20:49:30.097 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:30 rivo-aki qobuz-connect[3775]: 20250916 20:49:30.097 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:30 rivo-aki qobuz-connect[3775]: 20250916 20:49:30.097 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:30 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:30 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:30 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:30 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:31 rivo-aki volumio[3106]: info: Executing endpoint metavolumio Sep 16 20:49:31 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 16 20:49:31 rivo-aki volumio[3106]: info: Executing endpoint metavolumio Sep 16 20:49:31 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 16 20:49:31 rivo-aki volumio[3106]: info: Executing endpoint metavolumio Sep 16 20:49:31 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 16 20:49:32 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:32 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:33 rivo-aki volumio[3106]: error: Failed request for metavolumio API Sep 16 20:49:34 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:35 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:37 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:38 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:38 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:38 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:39 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:49:39 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:49:39 rivo-aki volumio[3106]: info: Discovery: Getting this device information Sep 16 20:49:39 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:39 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:49:40 rivo-aki qobuz-connect[3775]: 20250916 20:49:40.106 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:40 rivo-aki qobuz-connect[3775]: 20250916 20:49:40.106 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:40 rivo-aki qobuz-connect[3775]: 20250916 20:49:40.106 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:40 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:40 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:40 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:40 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:40 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:40 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:43 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:43 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:44 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:44 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:45 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:45 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:47 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:48 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:48 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:49 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:49 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:49 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:50 rivo-aki qobuz-connect[3775]: 20250916 20:49:50.106 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:49:50 rivo-aki qobuz-connect[3775]: 20250916 20:49:50.106 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:49:50 rivo-aki qobuz-connect[3775]: 20250916 20:49:50.106 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:50 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:49:50 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:49:50 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:50 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:51 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:51 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:52 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:53 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:53 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:54 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:55 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:55 rivo-aki volumio[3106]: error: Error browsing14:Error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:55 rivo-aki volumio[3106]: error: Failed to execute browseSource: Sep 16 20:49:55 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:55 rivo-aki volumio[3106]: error: Error browsing14:Error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:55 rivo-aki volumio[3106]: error: Failed to execute browseSource: Sep 16 20:49:56 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 16 20:49:56 rivo-aki volumio[3106]: error: Error browsing4:Error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:56 rivo-aki volumio[3106]: error: Failed to execute browseSource: Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.059 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 41]: Running audio stream Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO UrlAudioSource: [0xabe85ac8]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=3320072&eid=155665120&fmt=7&profile=raw&app_id=174516466&cid=2383074&etsp=1758026700&hmac=0x4f7q3ecQcUWuok7JvDd8zLgYU Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO ContentFetcher: [0xabdd1740]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=3320072&eid=155665120&fmt=7&profile=raw&app_id=174516466&cid=2383074&etsp=1758026700&hmac=0x4f7q3ecQcUWuok7JvDd8zLgYU, offset: 0 Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO SampleApp: [Stream 41]: New audio stream (starting from 0ms) Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO SampleApp: [Stream 41]: Stream metadata became available: Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO SampleApp: Title: Trioon II Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO SampleApp: Artist: Alva Noto Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.060 [3775.3775] INFO SampleApp: Album: Vrioon Sep 16 20:49:59 rivo-aki qobuz-connect[3775]: 20250916 20:49:59.061 [3775.3775] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/bc/pg/hf6mqkud3pgbc_600.jpg Sep 16 20:49:59 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-61532 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64979 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64992 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64985 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64982 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64990 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64987 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-65042 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64972 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64975 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-75663 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-70097 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-71200 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-59767 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-59848 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73733 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62522 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-68179 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62736 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73236 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72402 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-74408 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72446 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67393 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67386 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-61532 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64979 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64992 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64985 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: verbose: New Socket.io Connection to 192.168.1.25:3000 from 192.168.1.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64982 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64990 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64987 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-65042 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64972 in service upnp_browser Sep 16 20:49:59 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:49:59 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-64975 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-75663 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-70097 in service upnp_browser Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.106 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.107 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.107 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:00 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:00 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:00 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:00 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-71200 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-59767 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-59848 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73733 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62522 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-68179 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62736 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73236 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72402 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-74408 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72446 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67393 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Preloading song: upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67386 Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-59848 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73733 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62522 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-68179 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-62736 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-73236 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.548 [3775.3775] INFO UrlAudioSource: [0xabe85ac8]: Content info extracted Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.548 [3775.3775] INFO UrlAudioSource: [0xabe85ac8]: Size: 43621252 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.556 [3775.30817] INFO AudioDecoder: [0xabe66138]: Stream info: Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.557 [3775.30817] INFO AudioDecoder: [0xabe66138]: Total samples: 26255925 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.557 [3775.30817] INFO AudioDecoder: [0xabe66138]: Sample rate: 44100 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.557 [3775.30817] INFO AudioDecoder: [0xabe66138]: Channel count: 2 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.558 [3775.30817] INFO AudioDecoder: [0xabe66138]: Bits per sample: 24 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.558 [3775.30817] INFO AudioDecoder: [0xabe66138]: Duration: 595372 Sep 16 20:50:00 rivo-aki qobuz-connect[3775]: 20250916 20:50:00.560 [3775.3775] INFO UrlAudioSource: [0xabe85ac8]: Audio properties have changed Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72402 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-74408 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-72446 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67393 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:00 rivo-aki volumio[3106]: info: Exploding uri upnp/http://192.168.1.10:2869/upnphost/udhisapi.dll?control=uuid:aaf7260a-bf2e-4488-9037-f76f763e6588+urn:upnp-org:serviceId:ContentDirectory@4-67386 in service upnp_browser Sep 16 20:50:00 rivo-aki volumio[3106]: error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"720"}],"errorDescription":[{"_":"Cannot process the request"}]}]}]}]}]}} Sep 16 20:50:02 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 16 20:50:02 rivo-aki volumio[3106]: info: CURURI: music-library Sep 16 20:50:02 rivo-aki mpd[3759]: exception: No database Sep 16 20:50:02 rivo-aki volumio[3106]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Sep 16 20:50:02 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:50:04 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:50:06 rivo-aki qobuz-connect[3775]: 20250916 20:50:06.396 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 40]: Audio stream has finished Sep 16 20:50:06 rivo-aki qobuz-connect[3775]: 20250916 20:50:06.396 [3775.3775] INFO SampleApp: [Stream 40]: Audio stream finished Sep 16 20:50:06 rivo-aki qobuz-connect[3775]: 20250916 20:50:06.396 [3775.3775] INFO SampleApp: Playback is nearly finished Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.061 [3775.3775] INFO SampleApp: Playback has finished Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.063 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 40]: Disposing of audio stream Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.063 [3775.3775] INFO ContentFetcher: [0xabdf5678]: Canceling download Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.064 [3775.3775] INFO SampleApp: [Stream 40]: Audio stream has been disposed of Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.065 [3775.3775] INFO StreamingEventReporter: [0xabb7a950]: Reporting streaming ended event Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.066 [3775.3775] INFO HttpDownloader: [0xabb7a9a8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.076 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.076 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.077 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.078 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Need to send state update Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.078 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending StateUpdated message Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.078 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.079 [3775.3775] INFO QConnectMessageSender: [0xabd05ac0]: Sending FileAudioQualityChanged message Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.079 [3775.3775] INFO QwspMessageSender: [0xabd05ab0]: Sending Payload message Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.079 [3775.3775] INFO StreamingEventReporter: [0xabb7a950]: Reporting streaming started event Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.103 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Received SetState message: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Playing state: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Playback position: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Queue version: 6.1 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Current track: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Next track: TID: 155665121, QID: 6, Context UUID: 58825b8c-aafb-48c2-b29e-42f60770f945 Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO MediaEngine: [0xabb79df8]: Setting next track: 155665121 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: New stream: 42 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO HttpDownloader: [0xabe8cad0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=f2f49abb99645c32df6bcf062e454407&request_ts=1758023409&track_id=155665121 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.104 [3775.3775] INFO HttpDownloader: [0xac06a630]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=155665121 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.105 [3775.3775] INFO HttpDownloader: [0xabdb95d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=cbc8841e71519c48f16068a558f63d53&request_ts=1758023409&track_id=155665121 Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Received SetState message: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Playing state: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Playback position: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Queue version: 6.1 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Current track: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.111 [3775.3775] INFO ProtocolHandler: [0xabb7a538]: Next track: TID: 155665121, QID: 6, Context UUID: 58825b8c-aafb-48c2-b29e-42f60770f945 Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::servicePushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreStateMachine::pushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioPushState Sep 16 20:50:09 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output update for this device Sep 16 20:50:09 rivo-aki volumio[3106]: info: MRS: Pushing multiroomSync output Sep 16 20:50:09 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:09 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:09 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:09 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:09 rivo-aki volumio[3106]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.820 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 42]: stream information have been fetched Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.822 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 42]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=3320072&eid=155665121&fmt=7&profile=raw&app_id=174516466&cid=2383074&etsp=1758027009&hmac=KrwjuxQ2wHPl9gnJhOgEtRx_eOQ Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.877 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: [Stream 42]: Metadata became available: Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.877 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: Title: Landscape Skizze Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.877 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: Artist: Alva Noto Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.877 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: Album: Vrioon Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.877 [3775.3775] INFO AudioStreamManager: [0xabb79ee0]: Album art URL: https://static.qobuz.com/images/covers/bc/pg/hf6mqkud3pgbc_600.jpg Sep 16 20:50:09 rivo-aki qobuz-connect[3775]: 20250916 20:50:09.943 [3775.3775] INFO HttpDownloader: [0xabb7a9a8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Sep 16 20:50:11 rivo-aki volumio[3106]: info: Preload queue cleared Sep 16 20:50:12 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:50:12 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:50:12 rivo-aki volumio[3106]: info: Discovery: Getting this device information Sep 16 20:50:12 rivo-aki volumio[3106]: info: CoreCommandRouter::volumioGetState Sep 16 20:50:12 rivo-aki volumio[3106]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:50:12 rivo-aki volumio[3106]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 20:50:12 rivo-aki volumio[3106]: TypeError: Cannot read property 'length' of undefined Sep 16 20:50:12 rivo-aki volumio[3106]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 16 20:50:12 rivo-aki volumio[3106]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 16 20:50:12 rivo-aki volumio[3106]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 16 20:50:12 rivo-aki volumio[3106]: at Parser.emit (events.js:400:28) Sep 16 20:50:12 rivo-aki volumio[3106]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 16 20:50:12 rivo-aki volumio[3106]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 16 20:50:12 rivo-aki volumio[3106]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 16 20:50:12 rivo-aki volumio[3106]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 16 20:50:12 rivo-aki volumio[3106]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 16 20:50:12 rivo-aki volumio[3106]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 16 20:50:12 rivo-aki volumio[3106]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 16 20:50:12 rivo-aki volumio[3106]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 16 20:50:12 rivo-aki volumio[3106]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 16 20:50:12 rivo-aki volumio[3106]: at IncomingMessage.emit (events.js:412:35) Sep 16 20:50:12 rivo-aki volumio[3106]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 16 20:50:12 rivo-aki volumio[3106]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 16 20:50:12 rivo-aki volumio[3106]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 20:50:13 rivo-aki sudo[30866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-16 20:49 Sep 16 20:50:13 rivo-aki sudo[30866]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:43:09 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="fc7d09bc07ffd188bff4808d8f79c746"