May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 4]: Running audio stream
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO UrlAudioSource: [0x55eafaa7d020]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=9858381&eid=645150&fmt=6&profile=raw&app_id=174516466&cid=4062016&etsp=1779737605&hmac=Rkj_Pqp08U7qmMGpFtiLiYPNAoc
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO ContentFetcher: [0x55eafaaeeaa0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=9858381&eid=645150&fmt=6&profile=raw&app_id=174516466&cid=4062016&etsp=1779737605&hmac=Rkj_Pqp08U7qmMGpFtiLiYPNAoc, offset: 0
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: [Stream 4]: New audio stream (starting from 0ms)
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: [Stream 4]: Stream metadata became available:
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: Title: Poursuite Et Métro (Bof Temoin Dans La Ville)
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: Artist: Barney Wilen
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: Album: Un Temoin Dans La Ville (Bof Temoin Dans La Ville)
May 25 20:37:02 volumio qobuz-connect[1977]: 20260525 20:37:02.754 [1977.1977] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/62/24/0004400772462_600.jpg
May 25 20:37:02 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.1977] INFO UrlAudioSource: [0x55eafaa7d020]: Content info extracted
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.1977] INFO UrlAudioSource: [0x55eafaa7d020]: Size: 6712480
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Stream info:
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Total samples: 5684784
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Sample rate: 44100
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Channel count: 2
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Bits per sample: 16
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.3930] INFO AudioDecoder: [0x55eafaa7cb30]: Duration: 128906
May 25 20:37:03 volumio qobuz-connect[1977]: 20260525 20:37:03.539 [1977.1977] INFO UrlAudioSource: [0x55eafaa7d020]: Audio properties have changed
May 25 20:37:03 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:03 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:03 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:03 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:03 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:05 volumio qobuz-connect[1977]: 20260525 20:37:05.751 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:05 volumio qobuz-connect[1977]: 20260525 20:37:05.751 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:05 volumio qobuz-connect[1977]: 20260525 20:37:05.751 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:05 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:05 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:05 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:05 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:08 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:08 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:08 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:08 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:08 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:11 volumio qobuz-connect[1977]: 20260525 20:37:11.284 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 3]: Audio stream has finished
May 25 20:37:11 volumio qobuz-connect[1977]: 20260525 20:37:11.284 [1977.1977] INFO SampleApp: [Stream 3]: Audio stream finished
May 25 20:37:11 volumio qobuz-connect[1977]: 20260525 20:37:11.284 [1977.1977] INFO SampleApp: Playback is nearly finished
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.752 [1977.1977] INFO SampleApp: Playback has finished
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.752 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 3]: Disposing of audio stream
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.752 [1977.1977] INFO ContentFetcher: [0x55eafac6a180]: Canceling download
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.752 [1977.1977] INFO SampleApp: [Stream 3]: Audio stream has been disposed of
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO StreamingEventReporter: [0x55eafaa6f460]: Reporting streaming ended event
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO HttpDownloader: [0x55eafaa6f4f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.753 [1977.1977] INFO StreamingEventReporter: [0x55eafaa6f460]: Reporting streaming started event
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Received SetState message:
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Playing state:
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Playback position:
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Queue version: 1.2
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Current track:
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Next track: TID: 645151, QID: 4, Context UUID: 5e1fde35-7196-492c-9ca3-b3856e710b5c
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO MediaEngine: [0x55eafaa6e320]: Setting next track: 645151
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: New stream: 5
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO HttpDownloader: [0x55eafad59b20]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=a7f1ac64b66f73439747f64cfec6b8ee&request_ts=1779734232&track_id=645151
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO HttpDownloader: [0x55eafad4d040]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=645151
May 25 20:37:12 volumio qobuz-connect[1977]: 20260525 20:37:12.821 [1977.1977] INFO HttpDownloader: [0x55eafadb7350]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e5ac886d7e40c178a5bbb12ccd20f480&request_ts=1779734232&track_id=645151
May 25 20:37:13 volumio qobuz-connect[1977]: 20260525 20:37:13.081 [1977.1977] INFO HttpDownloader: [0x55eafaa6f4f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
May 25 20:37:13 volumio qobuz-connect[1977]: 20260525 20:37:13.086 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=9858381&eid=645151&fmt=6&profile=raw&app_id=174516466&cid=4062016&etsp=1779737832&hmac=9EubiwF1FGXmjfnpHkXbqZWMF-s
May 25 20:37:13 volumio qobuz-connect[1977]: 20260525 20:37:13.198 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 5]: stream information have been fetched
May 25 20:37:13 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:13 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:13 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:13 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:13 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:14 volumio qobuz-connect[1977]: 20260525 20:37:14.291 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 5]: Metadata became available:
May 25 20:37:14 volumio qobuz-connect[1977]: 20260525 20:37:14.291 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: Title: Ambiance Pourpre (Bof Un Temoin Dans La Ville)
May 25 20:37:14 volumio qobuz-connect[1977]: 20260525 20:37:14.291 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: Artist: Barney Wilen
May 25 20:37:14 volumio qobuz-connect[1977]: 20260525 20:37:14.291 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: Album: Un Temoin Dans La Ville (Bof Un Temoin Dans La Ville)
May 25 20:37:14 volumio qobuz-connect[1977]: 20260525 20:37:14.291 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: Album art URL: https://static.qobuz.com/images/covers/62/24/0004400772462_600.jpg
May 25 20:37:16 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:37:16 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 29) (YouTube) Incoming message: 'noop'
May 25 20:37:16 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 29) (YouTube) Not handled: 'noop'
May 25 20:37:18 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:18 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:18 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:18 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:18 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:22 volumio qobuz-connect[1977]: 20260525 20:37:22.753 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:22 volumio qobuz-connect[1977]: 20260525 20:37:22.753 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:22 volumio qobuz-connect[1977]: 20260525 20:37:22.753 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:22 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:22 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:22 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:22 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:23 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:23 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:24 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:24 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:24 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:25 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:37:25 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 29) (YouTube Music) Incoming message: 'noop'
May 25 20:37:25 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 29) (YouTube Music) Not handled: 'noop'
May 25 20:37:29 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:29 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:29 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:29 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:29 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:32 volumio qobuz-connect[1977]: 20260525 20:37:32.754 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:32 volumio qobuz-connect[1977]: 20260525 20:37:32.754 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:32 volumio qobuz-connect[1977]: 20260525 20:37:32.754 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:32 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:32 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:32 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:32 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:32 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:32 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:34 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:34 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:34 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:34 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:34 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:39 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:39 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:39 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:39 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:39 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:42 volumio qobuz-connect[1977]: 20260525 20:37:42.755 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:42 volumio qobuz-connect[1977]: 20260525 20:37:42.755 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:42 volumio qobuz-connect[1977]: 20260525 20:37:42.755 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:42 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:42 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:42 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:42 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:42 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:42 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:44 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:44 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:44 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:44 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:44 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:45 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:37:45 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 30) (YouTube) Incoming message: 'noop'
May 25 20:37:45 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 30) (YouTube) Not handled: 'noop'
May 25 20:37:47 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
May 25 20:37:48 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
May 25 20:37:48 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
May 25 20:37:49 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:49 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:49 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:49 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:49 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:50 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:37:50 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 30) (YouTube Music) Incoming message: 'noop'
May 25 20:37:50 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 30) (YouTube Music) Not handled: 'noop'
May 25 20:37:52 volumio qobuz-connect[1977]: 20260525 20:37:52.756 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:37:52 volumio qobuz-connect[1977]: 20260525 20:37:52.756 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:37:52 volumio qobuz-connect[1977]: 20260525 20:37:52.756 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:37:52 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:52 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:37:52 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:37:52 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:37:52 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:37:52 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:37:54 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:54 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:54 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:54 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:54 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:37:59 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:59 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:59 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:37:59 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:37:59 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:02 volumio qobuz-connect[1977]: 20260525 20:38:02.757 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:02 volumio qobuz-connect[1977]: 20260525 20:38:02.757 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:02 volumio qobuz-connect[1977]: 20260525 20:38:02.757 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:02 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:02 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:02 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:02 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:02 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:02 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:04 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:04 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:04 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:04 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:04 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:09 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:09 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:09 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:09 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:09 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:11 volumio sudo[4180]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 25 20:38:11 volumio sudo[4180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 20:38:11 volumio sudo[4180]: pam_unix(sudo:session): session closed for user root
May 25 20:38:11 volumio sudo[4181]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 25 20:38:11 volumio sudo[4181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 25 20:38:11 volumio sudo[4181]: pam_unix(sudo:session): session closed for user root
May 25 20:38:11 volumio volumio[1096]: verbose: New Socket.io Connection to 192.168.1.50 from 192.168.1.7 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7
May 25 20:38:11 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetVisibleSources
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 25 20:38:12 volumio volumio[1096]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
May 25 20:38:12 volumio volumio[1096]: info: Received Get System Info
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 20:38:12 volumio volumio[1096]: info: Discovery: Getting this device information
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:12 volumio volumio[1096]: info: Listing playlists
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 25 20:38:12 volumio qobuz-connect[1977]: 20260525 20:38:12.758 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:12 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:12 volumio qobuz-connect[1977]: 20260525 20:38:12.759 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:12 volumio qobuz-connect[1977]: 20260525 20:38:12.759 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:12 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:13 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:38:13 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 31) (YouTube) Incoming message: 'noop'
May 25 20:38:13 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 31) (YouTube) Not handled: 'noop'
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 20:38:13 volumio volumio[1096]: info: Received Get System Info
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 20:38:13 volumio volumio[1096]: info: Discovery: Getting this device information
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:13 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 20:38:14 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:14 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:14 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:14 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:14 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:14 volumio volumio[1096]: info: Executing endpoint metavolumio
May 25 20:38:14 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 25 20:38:14 volumio volumio[1096]: info: Executing endpoint metavolumio
May 25 20:38:14 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 25 20:38:14 volumio volumio[1096]: info: Executing endpoint metavolumio
May 25 20:38:14 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 25 20:38:15 volumio volumio[1096]: info: Received Get System Info
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 20:38:15 volumio volumio[1096]: info: Discovery: Getting this device information
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 20:38:15 volumio volumio[1096]: info: CoreCommandRouter::volumioGetQueue
May 25 20:38:15 volumio volumio[1096]: info: CoreStateMachine::getQueue
May 25 20:38:15 volumio volumio[1096]: info: CorePlayQueue::getQueue
May 25 20:38:19 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:38:19 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 31) (YouTube Music) Incoming message: 'noop'
May 25 20:38:19 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 31) (YouTube Music) Not handled: 'noop'
May 25 20:38:19 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:19 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:19 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:19 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:19 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:21 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 25 20:38:21 volumio volumio[1096]: error: Failed request for metavolumio API
May 25 20:38:22 volumio qobuz-connect[1977]: 20260525 20:38:22.759 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:22 volumio qobuz-connect[1977]: 20260525 20:38:22.759 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:22 volumio qobuz-connect[1977]: 20260525 20:38:22.759 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:22 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:22 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:22 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:22 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:22 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:22 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:25 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:25 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:25 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:25 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:25 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:27 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 25 20:38:27 volumio volumio[1096]: info: CURURI: music-library/USB/HD_Musica/Musica/Audiophile
May 25 20:38:27 volumio volumio[1096]: info: Preload queue cleared
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 25 20:38:30 volumio volumio[1096]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 25 20:38:30 volumio volumio[1096]: info: Received Get System Version
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 25 20:38:30 volumio volumio[1096]: info: Received Get System Info
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 25 20:38:30 volumio volumio[1096]: info: Discovery: Getting this device information
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:30 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 25 20:38:32 volumio qobuz-connect[1977]: 20260525 20:38:32.760 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:32 volumio qobuz-connect[1977]: 20260525 20:38:32.760 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:32 volumio qobuz-connect[1977]: 20260525 20:38:32.760 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:32 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:32 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:32 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:32 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:32 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:32 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:35 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:35 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:35 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:35 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:35 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:39 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:38:39 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 32) (YouTube) Incoming message: 'noop'
May 25 20:38:39 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 32) (YouTube) Not handled: 'noop'
May 25 20:38:39 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 25 20:38:39 volumio volumio[1096]: info: CURURI: music-library/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon
May 25 20:38:39 volumio volumio[1096]: info: Preload queue cleared
May 25 20:38:40 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:40 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:40 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:40 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:40 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:42 volumio qobuz-connect[1977]: 20260525 20:38:42.761 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:42 volumio qobuz-connect[1977]: 20260525 20:38:42.761 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:42 volumio qobuz-connect[1977]: 20260525 20:38:42.761 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:42 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:42 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:42 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:42 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:42 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:42 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:43 volumio volumio[1096]: verbose: -----------------------------------
May 25 20:38:43 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 32) (YouTube Music) Incoming message: 'noop'
May 25 20:38:43 volumio volumio[1096]: verbose: [yt-cast-receiver] (AID: 32) (YouTube Music) Not handled: 'noop'
May 25 20:38:45 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:45 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:45 volumio volumio[1096]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 25 20:38:45 volumio volumio[1096]: info: Discovery: Restarting Browsing
May 25 20:38:45 volumio volumio[1096]: info: Discovery: Restart already pending, ignoring duplicate call
May 25 20:38:48 volumio volumio[1096]: info: Preload queue cleared
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::ClearQueue
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::stop
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::serviceStop
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::serviceStop
May 25 20:38:48 volumio volumio[1096]: info: QobuzConnect: Received stop
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.565 [1977.1977] INFO MediaEngine: [0x55eafaa6e320]: Stopping playback, keeping tracks
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.565 [1977.1977] INFO AudioRenderer: [0x55eafaa6e5a0]: Stopping audio renderer
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.565 [1977.1977] INFO SampleApp: Stopping playback
May 25 20:38:48 volumio volumio[1096]: info: CorePlayQueue::clearPlayQueue
May 25 20:38:48 volumio volumio[1096]: info: CorePlayQueue::saveQueue
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioPushQueue
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::addQueueItems
May 25 20:38:48 volumio volumio[1096]: info: CorePlayQueue::addQueueItems
May 25 20:38:48 volumio volumio[1096]: info: Preload queue cleared
May 25 20:38:48 volumio volumio[1096]: info: Adding Item to queue: music-library/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On
May 25 20:38:48 volumio volumio[1096]: info: Exploding uri music-library/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On in service mpd
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.595 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 4]: Disposing of audio stream
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.595 [1977.1977] INFO ContentFetcher: [0x55eafaaeeaa0]: Canceling download
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: New stream: 6
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafafb13e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=8353ff3c4d4e9810e907215c9884d176&request_ts=1779734328&track_id=645150
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafac259e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=645150
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafae25d30]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=242c24b28751f0b829126996cf2efc9d&request_ts=1779734328&track_id=645150
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: [Stream 6]: Running audio stream
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO AudioStreamManager: [0x55eafaa6e450]: New stream: 7
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafad46470]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=85a4ad2aae95f5e17243722c6170f581&request_ts=1779734328&track_id=645151
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafb0a8660]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=645151
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.597 [1977.1977] INFO HttpDownloader: [0x55eafacab720]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=1716eef3f73d9ad782251501bb6f54e5&request_ts=1779734328&track_id=645151
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO SampleApp: Playback state changed: Stopped
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO StreamingEventReporter: [0x55eafaa6f460]: Reporting streaming ended event
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO HttpDownloader: [0x55eafaa6f4f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO ProtocolHandler: [0x55eafaa6ed90]: Need to send state update
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO QConnectMessageSender: [0x55eafaacbbf0]: Sending StateUpdated message
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.599 [1977.1977] INFO QwspMessageSender: [0x55eafac8d220]: Sending Payload message
May 25 20:38:48 volumio qobuz-connect[1977]: 20260525 20:38:48.600 [1977.1977] INFO SampleApp: [Stream 4]: Audio stream has been disposed of
May 25 20:38:48 volumio volumio[1096]: info: QobuzConnect: playback_stop received, deferred solved
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::servicePushState
May 25 20:38:48 volumio volumio[1096]: info: CoreStateMachine::pushState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioPushState
May 25 20:38:48 volumio volumio[1096]: info: CoreCommandRouter::volumioGetState
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F01%20I%20Know%20Just%20What%20I'd%20Do.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/01 I Know Just What I'd Do.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F02%20You%20Take%20My%20Breath%20Away.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/02 You Take My Breath Away.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F03%20I%20Can't%20Forgive%20You.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/03 I Can't Forgive You.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F04%20Feathers.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/04 Feathers.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F05%20Blue%20Dress%20On.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/05 Blue Dress On.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F06%20You%20Do%20Not.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/06 You Do Not.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F07%20She%20Moved%20Through%20The%20Fair.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/07 She Moved Through The Fair.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F08%20Sailor's%20Marriage.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/08 Sailor's Marriage.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F09%20You%20Have%20Got%20My%20Number.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/09 You Have Got My Number.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F10%20The%20Lake.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/10 The Lake.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F11%20Come%20Up%20To%20My%20Room.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/11 Come Up To My Room.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F12%20Tonight.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/12 Tonight.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2F13%20My%20Fantasy.flac&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/13 My Fantasy.flac
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2FRebecca%20Pidgeon%20-%20Blue%20Dress%20On%20-%202013%20FLAC.cuetools.flac.cue&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/Rebecca Pidgeon - Blue Dress On - 2013 FLAC.cuetools.flac.cue
May 25 20:38:48 volumio volumio[1096]: info: ALBUMART /albumart?cacheid=111&web=Rebecca%20Pidgeon/Blue%20Dress%20On/mega&path=%2Fmnt%2FUSB%2FHD_Musica%2FMusica%2FAudiophile%2FRebecca%20Pidgeon%2FBlue%20Dress%20On%2FRebecca%20Pidgeon%20-%20Blue%20Dress%20On%20-%202013%20FLAC.cuetools.flac.cue&metadata=false
May 25 20:38:48 volumio volumio[1096]: info: URI /mnt/USB/HD_Musica/Musica/Audiophile/Rebecca Pidgeon/Blue Dress On/Rebecca Pidgeon - Blue Dress On - 2013 FLAC.cuetools.flac.cue
May 25 20:38:48 volumio volumio[1096]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 20:38:48 volumio volumio[1096]: Error: Unable to resolve or reject the same promise twice
May 25 20:38:48 volumio volumio[1096]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
May 25 20:38:48 volumio volumio[1096]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
May 25 20:38:48 volumio volumio[1096]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
May 25 20:38:48 volumio volumio[1096]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
May 25 20:38:48 volumio volumio[1096]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
May 25 20:38:48 volumio volumio[1096]: at Socket.emit (node:events:514:28)
May 25 20:38:48 volumio volumio[1096]: at addChunk (node:internal/streams/readable:343:12)
May 25 20:38:48 volumio volumio[1096]: at readableAddChunk (node:internal/streams/readable:312:11)
May 25 20:38:48 volumio volumio[1096]: at Readable.push (node:internal/streams/readable:253:10)
May 25 20:38:48 volumio volumio[1096]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
May 25 20:38:48 volumio volumio[1096]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 20:38:48 volumio sudo[4327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-25 20:37'
May 25 20:38:48 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"