-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Fri 2025-06-13 23:25:50 GMT. -- Jun 13 23:24:00 volumio qobuz-connect[1311]: 20250613 23:24:00.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:00 volumio qobuz-connect[1311]: 20250613 23:24:00.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:00 volumio qobuz-connect[1311]: 20250613 23:24:00.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:00 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:00 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:24:10 volumio qobuz-connect[1311]: 20250613 23:24:10.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:10 volumio qobuz-connect[1311]: 20250613 23:24:10.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:10 volumio qobuz-connect[1311]: 20250613 23:24:10.485 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:10 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:10 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:24:20 volumio qobuz-connect[1311]: 20250613 23:24:20.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:20 volumio qobuz-connect[1311]: 20250613 23:24:20.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:20 volumio qobuz-connect[1311]: 20250613 23:24:20.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:20 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:20 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:24:30 volumio qobuz-connect[1311]: 20250613 23:24:30.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:30 volumio qobuz-connect[1311]: 20250613 23:24:30.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:30 volumio qobuz-connect[1311]: 20250613 23:24:30.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:30 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:30 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:24:35 volumio nmbd[752]: [2025/06/13 23:24:35.764544, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jun 13 23:24:35 volumio nmbd[752]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.194 for name WORKGROUP<1d>. Jun 13 23:24:35 volumio nmbd[752]: This response was from IP 192.168.1.153, reporting an IP address of 192.168.1.153. Jun 13 23:24:40 volumio qobuz-connect[1311]: 20250613 23:24:40.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:40 volumio qobuz-connect[1311]: 20250613 23:24:40.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:40 volumio qobuz-connect[1311]: 20250613 23:24:40.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:40 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:40 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:24:50 volumio qobuz-connect[1311]: 20250613 23:24:50.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:24:50 volumio qobuz-connect[1311]: 20250613 23:24:50.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:24:50 volumio qobuz-connect[1311]: 20250613 23:24:50.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:24:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:24:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:00 volumio qobuz-connect[1311]: 20250613 23:25:00.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:00 volumio qobuz-connect[1311]: 20250613 23:25:00.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:00 volumio qobuz-connect[1311]: 20250613 23:25:00.485 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:00 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:00 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:10 volumio qobuz-connect[1311]: 20250613 23:25:10.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:10 volumio qobuz-connect[1311]: 20250613 23:25:10.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:10 volumio qobuz-connect[1311]: 20250613 23:25:10.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:10 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:10 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:20 volumio qobuz-connect[1311]: 20250613 23:25:20.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:20 volumio qobuz-connect[1311]: 20250613 23:25:20.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:20 volumio qobuz-connect[1311]: 20250613 23:25:20.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:20 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:20 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:30 volumio qobuz-connect[1311]: 20250613 23:25:30.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:30 volumio qobuz-connect[1311]: 20250613 23:25:30.484 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:30 volumio qobuz-connect[1311]: 20250613 23:25:30.484 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:30 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:30 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:40 volumio qobuz-connect[1311]: 20250613 23:25:40.484 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:40 volumio qobuz-connect[1311]: 20250613 23:25:40.485 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:40 volumio qobuz-connect[1311]: 20250613 23:25:40.485 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:40 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:40 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.443 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 10]: Running audio stream Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.443 [1311.1311] INFO UrlAudioSource: [0x977d08]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=328970302&fmt=7&profile=raw&app_id=174516466&cid=2814091&etsp=1749860550&hmac=HCf_oMiEZ9LXz7u_GleLZE1Mq4A Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.443 [1311.1311] INFO ContentFetcher: [0x709870]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=328970302&fmt=7&profile=raw&app_id=174516466&cid=2814091&etsp=1749860550&hmac=HCf_oMiEZ9LXz7u_GleLZE1Mq4A, offset: 0 Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.456 [1311.1311] INFO SampleApp: [Stream 10]: New audio stream (starting from 0ms) Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.456 [1311.1311] INFO SampleApp: [Stream 10]: Stream metadata became available: Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.457 [1311.1311] INFO SampleApp: Title: Leaving Town (Woody Guthrie Festival) Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.457 [1311.1311] INFO SampleApp: Artist: Turnpike Troubadours Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.457 [1311.1311] INFO SampleApp: Album: The Price of Admission Jun 13 23:25:47 volumio qobuz-connect[1311]: 20250613 23:25:47.457 [1311.1311] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/hb/84/lelrukm1u84hb_600.jpg Jun 13 23:25:47 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:47 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.355 [1311.1311] INFO UrlAudioSource: [0x977d08]: Content info extracted Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.355 [1311.1311] INFO UrlAudioSource: [0x977d08]: Size: 96308815 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.355 [1311.5733] INFO AudioDecoder: [0x75d940]: Stream info: Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.355 [1311.5733] INFO AudioDecoder: [0x75d940]: Total samples: 24760320 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.355 [1311.5733] INFO AudioDecoder: [0x75d940]: Sample rate: 96000 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.356 [1311.5733] INFO AudioDecoder: [0x75d940]: Channel count: 2 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.356 [1311.5733] INFO AudioDecoder: [0x75d940]: Bits per sample: 24 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.356 [1311.5733] INFO AudioDecoder: [0x75d940]: Duration: 257920 Jun 13 23:25:48 volumio qobuz-connect[1311]: 20250613 23:25:48.356 [1311.1311] INFO UrlAudioSource: [0x977d08]: Audio properties have changed Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Received SetState message: Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Playing state: Playing Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Playback position: 0 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Queue version: 2.1 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Current track: TID: 96679502, QID: 0, Context UUID: b33c4208-aad5-4a7a-b7b1-58432cd5ace5 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO ProtocolHandler: [0x69c558]: Next track: TID: 96679503, QID: 1, Context UUID: b33c4208-aad5-4a7a-b7b1-58432cd5ace5 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO MediaEngine: [0x69be18]: Stopping playback, clearing tracks Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO MediaEngine: [0x69be18]: Initiating playback Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO AudioRenderer: [0x69c038]: Stopping audio renderer Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.395 [1311.1311] INFO SampleApp: Stopping playback Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.396 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Clearing all streams Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.396 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 9]: Disposing of audio stream Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.396 [1311.1311] INFO ContentFetcher: [0x9b2cc8]: Canceling download Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.403 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 10]: Disposing of audio stream Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.404 [1311.1311] INFO ContentFetcher: [0x709870]: Canceling download Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.412 [1311.1311] INFO SampleApp: Playback state changed: Stopped Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.412 [1311.1311] INFO StreamingEventReporter: [0x69c970]: Reporting streaming ended event Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.412 [1311.1311] INFO HttpDownloader: [0x69c9c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO SampleApp: [Stream 9]: Audio stream has been disposed of Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO MediaEngine: [0x69be18]: Setting current track: 96679502, initial offset: 0ms Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Clearing all streams Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO AudioStreamManager: [0x69bf00]: New stream: 11 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO HttpDownloader: [0x736ac0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=682a26f1f85337d5d0769e5e558afa5f&request_ts=1749857149&track_id=96679502 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO HttpDownloader: [0x85f3c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=96679502 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO HttpDownloader: [0x96cc58]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a54d9ab84169a842584479bf2c8e7cda&request_ts=1749857149&track_id=96679502 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 11]: Running audio stream Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.413 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:49 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:49 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO SampleApp: [Stream 10]: Audio stream has been disposed of Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO MediaEngine: [0x69be18]: Setting next track: 96679503 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO AudioStreamManager: [0x69bf00]: New stream: 12 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO HttpDownloader: [0x7b4268]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=b499e5fc3a15eeafe2251206a8034b10&request_ts=1749857149&track_id=96679503 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO HttpDownloader: [0x7b11c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=96679503 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.416 [1311.1311] INFO HttpDownloader: [0x7b2ea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=9119a67f9e39424170fcde4a734cb50d&request_ts=1749857149&track_id=96679503 Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.418 [1311.1311] INFO MediaEngine: [0x69be18]: Waiting for current stream to start before starting audio renderer Jun 13 23:25:49 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:49 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:49 volumio volumio[835]: info: camilladsp spawned new process with pid 5742, instance 1, run: true Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.960 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 11]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=96679502&fmt=6&profile=raw&app_id=174516466&cid=2814091&etsp=1749860749&hmac=lUBsBMzi9JLrmokPFrxpm7cu5hw Jun 13 23:25:49 volumio qobuz-connect[1311]: 20250613 23:25:49.988 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 12]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=96679503&fmt=6&profile=raw&app_id=174516466&cid=2814091&etsp=1749860749&hmac=tphDdn_z17bsBc5wee7q8_Mm1Ng Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.042 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 11]: stream information have been fetched Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.042 [1311.1311] INFO UrlAudioSource: [0x9993e0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=96679502&fmt=6&profile=raw&app_id=174516466&cid=2814091&etsp=1749860749&hmac=lUBsBMzi9JLrmokPFrxpm7cu5hw Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.042 [1311.1311] INFO ContentFetcher: [0x815b78]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=96679502&fmt=6&profile=raw&app_id=174516466&cid=2814091&etsp=1749860749&hmac=lUBsBMzi9JLrmokPFrxpm7cu5hw, offset: 0 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.043 [1311.1311] INFO AudioRenderer: [0x69c038]: Starting audio renderer, initial playback state: Playing Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.043 [1311.1311] INFO SampleApp: [Stream 11]: New audio stream (starting from 0ms) Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: QobuzConnect: setActiveState() Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.046 [1311.1311] INFO VolumeManager: [0x69c280]: Setting new playback volume: 10 Jun 13 23:25:50 volumio volumio[835]: info: QobuzConnect: Set Qobuz connect default volume to 10 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: QobuzConnect: Stopping currently active service Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioStop Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::stop Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::updateTrackBlock Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrackBlock Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::stPlaybackTimer Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::serviceStop Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::serviceStop Jun 13 23:25:50 volumio volumio[835]: info: [1749857150058] ControllerTidal::stop Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 13 23:25:50 volumio volumio[835]: info: ControllerMpd::stop Jun 13 23:25:50 volumio volumio[835]: verbose: ControllerMpd::sendMpdCommand stop Jun 13 23:25:50 volumio volumio[835]: info: sendMpdCommand stop took 16 milliseconds Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::servicePushState Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Jun 13 23:25:50 volumio volumio[835]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received qobuzconnect Jun 13 23:25:50 volumio volumio[835]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jun 13 23:25:50 volumio volumio[835]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.118 [1311.1311] INFO SampleApp: Initiating playback, initial state: Playing Jun 13 23:25:50 volumio volumio[835]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 13 23:25:50 volumio volumio[835]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 13 23:25:50 volumio volumio[835]: info: camilladsp stopping service pid 5742... Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.152 [1311.1311] INFO SampleApp: Playback state changed: Playing Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.152 [1311.1311] INFO StreamingEventReporter: [0x69c970]: Reporting streaming started event Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.152 [1311.1311] INFO HttpDownloader: [0x69c9c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.152 [1311.1311] INFO ProtocolHandler: [0x69c558]: Need to send state update Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.152 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending StateUpdated message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.153 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.154 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending FileAudioQualityChanged message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.155 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.155 [1311.1311] INFO QConnectMessageSender: [0x6dc000]: Sending DeviceAudioQualityChanged message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.156 [1311.1311] INFO QwspMessageSender: [0x7a4ee8]: Sending Payload message Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.156 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 12]: stream information have been fetched Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 12]: Metadata became available: Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Title: Dixieland Delight Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Artist: Old Crow Medicine Show Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Album: High Cotton: The Songs of Alabama Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Album art URL: https://static.qobuz.com/images/covers/ob/hp/u3lu5ibwphpob_600.jpg Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: [Stream 11]: Metadata became available: Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Title: Why Lady Why Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Artist: JD McPherson Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Album: High Cotton: The Songs of Alabama Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO AudioStreamManager: [0x69bf00]: Album art URL: https://static.qobuz.com/images/covers/ob/hp/u3lu5ibwphpob_600.jpg Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO SampleApp: [Stream 11]: Stream metadata became available: Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO SampleApp: Title: Why Lady Why Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO SampleApp: Artist: JD McPherson Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO SampleApp: Album: High Cotton: The Songs of Alabama Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.157 [1311.1311] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ob/hp/u3lu5ibwphpob_600.jpg Jun 13 23:25:50 volumio volumio[835]: info: camilladsp service terminated, instance 1 Jun 13 23:25:50 volumio volumio[835]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 13 23:25:50 volumio volumio[835]: info: camilladsp service started and running in background, instance 1 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::servicePushState Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.177 [1311.1311] WARNING SampleApp: Command playback_set_volume misses volume argument Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.178 [1311.1311] INFO VolumeManager: [0x69c280]: Setting new mute state: 0 Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::servicePushState Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.184 [1311.1311] WARNING SampleApp: Command playback_set_volume misses volume argument Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::servicePushState Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.192 [1311.1311] WARNING SampleApp: Command playback_set_volume misses volume argument Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::servicePushState Jun 13 23:25:50 volumio volumio[835]: info: CoreStateMachine::pushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Jun 13 23:25:50 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.197 [1311.1311] WARNING SampleApp: Command playback_set_volume misses volume argument Jun 13 23:25:50 volumio volumio[835]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 13 23:25:50 volumio volumio[835]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 23:25:50 volumio volumio[835]: TypeError: Cannot read property 'indexOf' of undefined Jun 13 23:25:50 volumio volumio[835]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 13 23:25:50 volumio volumio[835]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 13 23:25:50 volumio volumio[835]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 13 23:25:50 volumio volumio[835]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 13 23:25:50 volumio volumio[835]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 13 23:25:50 volumio volumio[835]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 13 23:25:50 volumio volumio[835]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 13 23:25:50 volumio volumio[835]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 13 23:25:50 volumio volumio[835]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 13 23:25:50 volumio volumio[835]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 13 23:25:50 volumio volumio[835]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 13 23:25:50 volumio volumio[835]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 13 23:25:50 volumio volumio[835]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 13 23:25:50 volumio volumio[835]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 13 23:25:50 volumio volumio[835]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 13 23:25:50 volumio volumio[835]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 13 23:25:50 volumio volumio[835]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.384 [1311.1311] INFO UrlAudioSource: [0x9993e0]: Content info extracted Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.384 [1311.1311] INFO UrlAudioSource: [0x9993e0]: Size: 16531654 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Stream info: Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Total samples: 8052072 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Sample rate: 44100 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Channel count: 2 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Bits per sample: 16 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.5760] INFO AudioDecoder: [0xcc7c98]: Duration: 182586 Jun 13 23:25:50 volumio qobuz-connect[1311]: 20250613 23:25:50.385 [1311.1311] INFO UrlAudioSource: [0x9993e0]: Audio properties have changed Jun 13 23:25:50 volumio sudo[5763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-13 23:24 Jun 13 23:25:50 volumio sudo[5763]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"