-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Wed 2025-05-21 10:31:33 BST. --
May 21 10:30:00 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:00 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:00 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:00 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:03 volumio ntpd[823]: 176.58.109.199 local addr 192.168.0.4 ->
May 21 10:30:03 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:30:03 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:30:03 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:30:03 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:03 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:30:09 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:09 volumio volumio[1018]: info: Listing playlists
May 21 10:30:09 volumio volumio[1018]: info: Listing playlists
May 21 10:30:15 volumio volumio[1018]: info: CoreCommandRouter::volumioPause
May 21 10:30:15 volumio volumio[1018]: info: CoreStateMachine::pause
May 21 10:30:16 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:16 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:16 volumio volumio[1018]: info: ControllerMpd::next
May 21 10:30:16 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand next
May 21 10:30:17 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:17 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:17 volumio volumio[1018]: info: ControllerMpd::next
May 21 10:30:17 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand next
May 21 10:30:18 volumio volumio[1018]: info: CoreCommandRouter::volumioPause
May 21 10:30:18 volumio volumio[1018]: info: CoreStateMachine::pause
May 21 10:30:18 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:18 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:18 volumio volumio[1018]: info: ControllerMpd::next
May 21 10:30:18 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand next
May 21 10:30:19 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:21 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:21 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:21 volumio volumio[1018]: info: ControllerMpd::next
May 21 10:30:21 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand next
May 21 10:30:21 volumio volumio[1018]: info: CoreCommandRouter::volumioPause
May 21 10:30:21 volumio volumio[1018]: info: CoreStateMachine::pause
May 21 10:30:24 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:24 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:24 volumio volumio[1018]: info: ControllerMpd::next
May 21 10:30:24 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand next
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.322 [3098.3170] INFO SampleApp: API endpoint invoked: get-connect-info
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3170] INFO SampleApp: API endpoint invoked: connect-to-qconnect
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO EndpointManager: [0xf8e160]: Updating API endpoint
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO EndpointManager: [0xf8e160]: Updating QConnect endpoint
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO ActiveStateManager: [0xf8d178]: Setting new active state: active
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO PlaybackSessionManager: [0xf8e550]: Starting playback session maintenance
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO HttpDownloader: [0xf8e740]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.493 [3098.3098] INFO CloudClient: [0xf8edc0]: Connecting to the cloud
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.494 [3098.3098] INFO SampleApp: Renderer is now active
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO CloudClient: [0xf8edc0]: Connection established
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Authenticate message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Subscribe message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending JoinSession message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeMuted message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.613 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending MaxAudioQualityChanged message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.614 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetActive message: active
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetState message:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playing state: Paused
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playback position: 22762
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Queue version: 3.9
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Current track: TID: 21416224, QID: 21, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Next track: TID: 76310448, QID: 22, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, clearing tracks
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Initiating playback
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO RendererActionAvailabilityManager: [0xf8ee78]: Renderer action 'Next' is available
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetLoopMode message: Off
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO PlaybackControlsManager: [0xf8ebc0]: Setting new loop mode: Off
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting current track: 21416224, initial offset: 22762ms
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Clearing all streams
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 1
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.642 [3098.3098] INFO HttpDownloader: [0x1069f38]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=0a119542f4f77da9d93a6841d2c38047&request_ts=1747819828&track_id=21416224
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO HttpDownloader: [0x106aec8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=21416224
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 1]: Running audio stream
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetShuffleMode message: disabled
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO PlaybackControlsManager: [0xf8ebc0]: Setting new shuffle mode: disabled
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting next track: 76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 2
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO HttpDownloader: [0x106be80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=344751dc7801bc98a27f0f1783a87a2d&request_ts=1747819828&track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO HttpDownloader: [0x106cec0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.643 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Waiting for current stream to start before starting audio renderer
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.665 [3098.3098] INFO PlaybackSessionManager: [0xf8e550]: Playback session has been refreshed
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.665 [3098.3098] INFO HttpDownloader: [0xf943e8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=56b6602333b5a70305282522933f4aaf&request_ts=1747819828&track_id=21416224
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.666 [3098.3098] INFO HttpDownloader: [0x1071008]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=6f5d61792826d1fad7e28bc8d33e2190&request_ts=1747819828&track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.699 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 2]: Metadata became available:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.699 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: Let Love Stand a Chance
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.699 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Charles Bradley
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.699 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Victim of Love
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.699 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/eb/1w/irzsbq2471web_600.jpg
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.720 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 1]: Metadata became available:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.720 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: Blak and Blu (Live)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.720 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Gary Clark Jr.
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.720 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Gary Clark Jr. Live (Live)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.720 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/00/20/0093624932000_600.jpg
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.724 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=21416224&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=OKqla_Cb8J9GmcOttuDpAxrnVeQ
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.736 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=76310448&fmt=6&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=7PVDCo6GkyGSIcR4SlKTnq5bEZc
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 1]: stream information have been fetched
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO UrlAudioSource: [0x113adb0]: Starting URL audio source, initial position: 22762ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=21416224&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=OKqla_Cb8J9GmcOttuDpAxrnVeQ
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO ContentFetcher: [0x106f390]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=21416224&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=OKqla_Cb8J9GmcOttuDpAxrnVeQ, offset: 0
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Starting audio renderer, initial playback state: Paused
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: [Stream 1]: New audio stream (starting from 22762ms)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: [Stream 1]: Stream metadata became available:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: Title: Blak and Blu (Live)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: Artist: Gary Clark Jr.
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: Album: Gary Clark Jr. Live (Live)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.780 [3098.3098] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/00/20/0093624932000_600.jpg
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: setActiveState()
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.782 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 20
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: Set Qobuz connect default volume to 20
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: Stopping currently active service
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioStop
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::stop
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.789 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 20
May 21 10:30:28 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: setActiveState() completed, send playback confirmation
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.793 [3098.3098] INFO SampleApp: Initiating playback, initial state: Paused
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.821 [3098.3098] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38)
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] ERROR AudioRenderer: [0xf8ea08]: Playback error occurred
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending PlaybackError message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.822 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:30:28 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetState message:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playing state: Playing
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playback position: 0
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Queue version: 3.9
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Current track: TID: 76310448, QID: 22, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Next track: TID: 35339602, QID: 23, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Reseting
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, clearing tracks
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.871 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Initiating playback
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Reseting audio renderer
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting current track: 76310448, initial offset: 0ms
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Clearing all streams
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 1]: Disposing of audio stream
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.872 [3098.3098] INFO ContentFetcher: [0x106f390]: Canceling download
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.874 [3098.3098] INFO HttpDownloader: [0x1071008]: Canceling download
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.874 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 3
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.874 [3098.3098] INFO HttpDownloader: [0x106be80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=344751dc7801bc98a27f0f1783a87a2d&request_ts=1747819828&track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.875 [3098.3098] INFO HttpDownloader: [0xf9a998]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.875 [3098.3098] INFO HttpDownloader: [0xf943e8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=6f5d61792826d1fad7e28bc8d33e2190&request_ts=1747819828&track_id=76310448
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.875 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 3]: Running audio stream
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO SampleApp: [Stream 1]: Audio stream has been disposed of
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting next track: 35339602
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 4
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO HttpDownloader: [0x1185d20]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=a3d8b49a183fe293de95cb6ff59b2666&request_ts=1747819828&track_id=35339602
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO HttpDownloader: [0x1173b90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=35339602
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.877 [3098.3098] INFO HttpDownloader: [0x1069ef8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=b3b94c8a1a4af05a28e2caf2bd6958cb&request_ts=1747819828&track_id=35339602
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.878 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Waiting for current stream to start before starting audio renderer
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:30:28 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.926 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 3]: Metadata became available:
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.926 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: Let Love Stand a Chance
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.926 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Charles Bradley
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.926 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Victim of Love
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.926 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/eb/1w/irzsbq2471web_600.jpg
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.933 [3098.3098] INFO SampleApp: Playback volume changed: 20
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.933 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 20
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.933 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.933 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:28 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 20
May 21 10:30:28 volumio volumio[1018]: info: VolumeController::SetAlsaVolume20
May 21 10:30:28 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:28 volumio qobuz-connect[3098]: 20250521 10:30:28.969 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=76310448&fmt=6&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=7PVDCo6GkyGSIcR4SlKTnq5bEZc
May 21 10:30:28 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.014 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 4]: Metadata became available:
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.014 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: A Very Good Year
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.014 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Ben L'Oncle Soul
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.015 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Under My Skin
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.015 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/96/77/0060255717796_600.jpg
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 3]: stream information have been fetched
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO UrlAudioSource: [0x1210900]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=76310448&fmt=6&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=7PVDCo6GkyGSIcR4SlKTnq5bEZc
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO ContentFetcher: [0xfc2830]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=76310448&fmt=6&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=7PVDCo6GkyGSIcR4SlKTnq5bEZc, offset: 0
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Starting audio renderer, initial playback state: Playing
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms)
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.016 [3098.3098] INFO SampleApp: [Stream 3]: Stream metadata became available:
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.017 [3098.3098] INFO SampleApp: Title: Let Love Stand a Chance
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.017 [3098.3098] INFO SampleApp: Artist: Charles Bradley
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.017 [3098.3098] INFO SampleApp: Album: Victim of Love
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.017 [3098.3098] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/eb/1w/irzsbq2471web_600.jpg
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: QobuzConnect: alread currrent service, send playback confirmation
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.018 [3098.3098] INFO SampleApp: Initiating playback, initial state: Playing
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.061 [3098.3098] INFO SampleApp: Playback state changed: Playing
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.061 [3098.3098] INFO StreamingEventReporter: [0xf8f340]: Reporting streaming started event
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.061 [3098.3098] INFO HttpDownloader: [0xf8f398]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.061 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.061 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:29 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:30:29 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:29 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.073 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.074 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending FileAudioQualityChanged message
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.074 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.074 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending DeviceAudioQualityChanged message
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.074 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=35339602&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823428&hmac=u2wIxaSD1fXR_ZNowMP6unHVUpI
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.074 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.075 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 4]: stream information have been fetched
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:29 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:29 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:29 volumio volumio[1018]: info: Listing playlists
May 21 10:30:29 volumio volumio[1018]: info: Listing playlists
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.367 [3098.3098] INFO UrlAudioSource: [0x1210900]: Content info extracted
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.367 [3098.3098] INFO UrlAudioSource: [0x1210900]: Size: 25493479
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.372 [3098.3189] INFO AudioDecoder: [0x11c4720]: Stream info:
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.372 [3098.3189] INFO AudioDecoder: [0x11c4720]: Total samples: 10558422
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.373 [3098.3189] INFO AudioDecoder: [0x11c4720]: Sample rate: 44100
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.373 [3098.3189] INFO AudioDecoder: [0x11c4720]: Channel count: 2
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.373 [3098.3189] INFO AudioDecoder: [0x11c4720]: Bits per sample: 16
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.373 [3098.3189] INFO AudioDecoder: [0x11c4720]: Duration: 239420
May 21 10:30:29 volumio qobuz-connect[3098]: 20250521 10:30:29.373 [3098.3098] INFO UrlAudioSource: [0x1210900]: Audio properties have changed
May 21 10:30:33 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:30:33 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:30:33 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:30:33 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:33 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.311 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 21
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.311 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 21
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.461 [3098.3098] INFO SampleApp: Playback volume changed: 21
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.461 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 21
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.461 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.461 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:36 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 21
May 21 10:30:36 volumio volumio[1018]: info: VolumeController::SetAlsaVolume21
May 21 10:30:36 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.484 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 21
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.646 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.646 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.797 [3098.3098] INFO SampleApp: Playback volume changed: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.797 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.797 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.797 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:36 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 22
May 21 10:30:36 volumio volumio[1018]: info: VolumeController::SetAlsaVolume22
May 21 10:30:36 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.820 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 23
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.820 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 23
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.820 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.970 [3098.3098] INFO SampleApp: Playback volume changed: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.970 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 22
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.970 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:36 volumio qobuz-connect[3098]: 20250521 10:30:36.970 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:36 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 22
May 21 10:30:36 volumio volumio[1018]: info: VolumeController::SetAlsaVolume22
May 21 10:30:36 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:36 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.298 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 29
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.298 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 29
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.339 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 33
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.339 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 33
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.339 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 37
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.339 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 37
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.340 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 42
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.340 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 42
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.358 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 47
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.358 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 47
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.373 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 51
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.373 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 51
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.391 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 56
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.391 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 56
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.408 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 60
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.408 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 60
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.424 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 63
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.424 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 63
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.442 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.442 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.448 [3098.3098] INFO SampleApp: Playback volume changed: 65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.448 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.448 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.448 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 65
May 21 10:30:37 volumio volumio[1018]: info: VolumeController::SetAlsaVolume65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.460 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 67
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.460 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 67
May 21 10:30:37 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.471 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 65
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.480 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 69
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.480 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 69
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.525 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 70
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.525 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 70
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.525 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 71
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.525 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 71
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.528 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 73
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.528 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 73
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.584 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 74
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.584 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 74
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.610 [3098.3098] INFO SampleApp: Playback volume changed: 74
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.610 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 74
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.610 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.610 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 74
May 21 10:30:37 volumio volumio[1018]: info: VolumeController::SetAlsaVolume74
May 21 10:30:37 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.639 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 74
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.798 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 73
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.798 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 73
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.826 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 72
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.826 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 72
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.947 [3098.3098] INFO SampleApp: Playback volume changed: 72
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.947 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 72
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.948 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.948 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 72
May 21 10:30:37 volumio volumio[1018]: info: VolumeController::SetAlsaVolume72
May 21 10:30:37 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:37 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:37 volumio qobuz-connect[3098]: 20250521 10:30:37.971 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 72
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.792 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 62
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.792 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 62
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.835 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 60
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.835 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 60
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.835 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 58
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.835 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 58
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.848 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 56
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.848 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 56
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.862 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 53
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.862 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 53
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.875 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 51
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.875 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 51
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.889 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 49
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.889 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 49
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.911 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 46
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.912 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 46
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.930 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 45
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.930 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 45
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO SampleApp: Playback volume changed: 45
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 45
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetVolume message, volume: 44
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.941 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 44
May 21 10:30:38 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:38 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 45
May 21 10:30:38 volumio volumio[1018]: info: VolumeController::SetAlsaVolume45
May 21 10:30:38 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:38 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:38 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:38 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:38 volumio qobuz-connect[3098]: 20250521 10:30:38.964 [3098.3098] INFO VolumeManager: [0xf8ec50]: Setting new playback volume: 45
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.061 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.061 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.061 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:39 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.092 [3098.3098] INFO SampleApp: Playback volume changed: 45
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.092 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Volume changed: 45
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.092 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending VolumeChanged message
May 21 10:30:39 volumio qobuz-connect[3098]: 20250521 10:30:39.092 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:39 volumio volumio[1018]: info: QobuzConnect: Volume received from daemon: 45
May 21 10:30:39 volumio volumio[1018]: info: VolumeController::SetAlsaVolume45
May 21 10:30:39 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:39 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetState message:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playing state: Paused
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playback position:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Queue version:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Current track:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Next track:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Pausing playback
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Pausing audio renderer
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] INFO SampleApp: Pausing playback
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.055 [3098.3098] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38)
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] ERROR AudioRenderer: [0xf8ea08]: Playback error occurred
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending PlaybackError message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO SampleApp: Playback state changed: Stopped
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO StreamingEventReporter: [0xf8f340]: Reporting streaming ended event
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO HttpDownloader: [0xf8f398]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.056 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.057 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetState message:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playing state: Playing
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Playback position: 0
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Queue version: 3.10
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Current track: TID: 35339602, QID: 23, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Next track: TID: 25189580, QID: 24, Context UUID: ef5a157a-305b-4834-be5f-2911f7c17ffe
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.083 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Reseting
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, clearing tracks
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Initiating playback
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Reseting audio renderer
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting current track: 35339602, initial offset: 0ms
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Clearing all streams
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 3]: Disposing of audio stream
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.084 [3098.3098] INFO ContentFetcher: [0xfc2830]: Canceling download
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.088 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 5
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.088 [3098.3098] INFO HttpDownloader: [0x1185d20]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=1e2b6f88df7db21cc8a9584497c6e68f&request_ts=1747819841&track_id=35339602
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.088 [3098.3098] INFO HttpDownloader: [0x1069f38]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=35339602
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.088 [3098.3098] INFO HttpDownloader: [0x1107688]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=71e44005c1f974e33cf653e6d9a17eea&request_ts=1747819841&track_id=35339602
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.088 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 5]: Running audio stream
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.089 [3098.3098] INFO SampleApp: [Stream 3]: Audio stream has been disposed of
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.089 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting next track: 25189580
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.089 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: New stream: 6
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.089 [3098.3098] INFO HttpDownloader: [0xfc9d48]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=5985deb3b824e903a5cca0edb5d97cef&request_ts=1747819841&track_id=25189580
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.090 [3098.3098] INFO HttpDownloader: [0x1175838]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=25189580
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.090 [3098.3098] INFO HttpDownloader: [0x1069d20]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=af034b7dab783e968e1f527b5b745c1b&request_ts=1747819841&track_id=25189580
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.090 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Waiting for current stream to start before starting audio renderer
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.148 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 5]: Metadata became available:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.148 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: A Very Good Year
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.148 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Ben L'Oncle Soul
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.148 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Under My Skin
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.148 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/96/77/0060255717796_600.jpg
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.177 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=35339602&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823441&hmac=YfT2eWJb5UG3PGCS1GK7PIrLPoY
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.206 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=25189580&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823441&hmac=HqT4CN5sCvd6IF9AldMCCco5Wv4
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 5]: stream information have been fetched
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO UrlAudioSource: [0xfceb00]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=35339602&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823441&hmac=YfT2eWJb5UG3PGCS1GK7PIrLPoY
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO ContentFetcher: [0xfa3e88]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2738519&eid=35339602&fmt=7&profile=raw&app_id=174516466&cid=2364782&etsp=1747823441&hmac=YfT2eWJb5UG3PGCS1GK7PIrLPoY, offset: 0
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Starting audio renderer, initial playback state: Playing
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: [Stream 5]: New audio stream (starting from 0ms)
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: [Stream 5]: Stream metadata became available:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: Title: A Very Good Year
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: Artist: Ben L'Oncle Soul
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: Album: Under My Skin
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.209 [3098.3098] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/96/77/0060255717796_600.jpg
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: QobuzConnect: alread currrent service, send playback confirmation
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.210 [3098.3098] INFO SampleApp: Initiating playback, initial state: Playing
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO SampleApp: Playback state changed: Playing
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO StreamingEventReporter: [0xf8f340]: Reporting streaming started event
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO HttpDownloader: [0xf8f398]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Need to send state update
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending StateUpdated message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.222 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.223 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending FileAudioQualityChanged message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.223 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.223 [3098.3098] INFO QConnectMessageSender: [0xfce908]: Sending DeviceAudioQualityChanged message
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.223 [3098.3098] INFO QwspMessageSender: [0x1098e88]: Sending Payload message
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:41 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:41 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.277 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 6]: Metadata became available:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.278 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Title: River
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.278 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Artist: Leon Bridges
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.278 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album: Coming Home
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.278 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Album art URL: https://static.qobuz.com/images/covers/97/38/0886445223897_600.jpg
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.278 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 6]: stream information have been fetched
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.376 [3098.3098] INFO UrlAudioSource: [0xfceb00]: Content info extracted
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.376 [3098.3098] INFO UrlAudioSource: [0xfceb00]: Size: 49426821
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Stream info:
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Total samples: 11430720
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Sample rate: 44100
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Channel count: 2
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Bits per sample: 24
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3213] INFO AudioDecoder: [0x11d0f88]: Duration: 259200
May 21 10:30:41 volumio qobuz-connect[3098]: 20250521 10:30:41.381 [3098.3098] INFO UrlAudioSource: [0xfceb00]: Audio properties have changed
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:49 volumio volumio[1018]: info: Listing playlists
May 21 10:30:49 volumio volumio[1018]: info: Listing playlists
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO ProtocolHandler: [0xf8ef28]: Received SetActive message: inactive
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO PlaybackSessionManager: [0xf8e550]: Stopping playback session maintenance
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO ActiveStateManager: [0xf8d178]: Setting new active state: inactive
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, clearing tracks
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Reseting
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO SampleApp: Renderer is now inactive
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO AudioRenderer: [0xf8ea08]: Stopping audio renderer
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO SampleApp: Stopping playback
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: Clearing all streams
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO AudioStreamManager: [0xf8e8d0]: [Stream 5]: Disposing of audio stream
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.548 [3098.3098] INFO ContentFetcher: [0xfa3e88]: Canceling download
May 21 10:30:49 volumio volumio[1018]: info: QobuzConnect: playback_stop received, deferred solved
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.551 [3098.3098] INFO SampleApp: Playback state changed: Stopped
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.552 [3098.3098] INFO StreamingEventReporter: [0xf8f340]: Reporting streaming ended event
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.552 [3098.3098] INFO HttpDownloader: [0xf8f398]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.552 [3098.3098] INFO SampleApp: [Stream 5]: Audio stream has been disposed of
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.552 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting current track: NONE
May 21 10:30:49 volumio qobuz-connect[3098]: 20250521 10:30:49.552 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Setting next track: NONE
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::servicePushState
May 21 10:30:49 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:30:49 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:56 volumio volumio[1018]: info: CoreCommandRouter::volumioVolatilePlay
May 21 10:30:56 volumio volumio[1018]: info: CoreStateMachine::volatilePlay
May 21 10:30:56 volumio volumio[1018]: info: QobuzConnect: Received play
May 21 10:30:56 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:56 volumio qobuz-connect[3098]: 20250521 10:30:56.852 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Resuming playback
May 21 10:30:58 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:30:58 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:30:58 volumio volumio[1018]: info: QobuzConnect: Received next
May 21 10:30:58 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:30:59 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:07 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:07 volumio volumio[1018]: verbose: New Socket.io Connection to 192.168.0.4:3000 from 192.168.0.131 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:07 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:09 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:09 volumio volumio[1018]: info: Listing playlists
May 21 10:31:09 volumio volumio[1018]: info: Listing playlists
May 21 10:31:10 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout
May 21 10:31:14 volumio volumio[1018]: info: [MyVolumio PluginManager] Subscribed plan changed to free
May 21 10:31:14 volumio volumio[1018]: info: [MyVolumio PluginManager] Device deactivated, disabling myvolumio plugins...
May 21 10:31:14 volumio volumio[1018]: info: ___________ STOPPING MYVOLUMIO PLUGINS ___________
May 21 10:31:14 volumio volumio[1018]: info:
May 21 10:31:14 volumio volumio[1018]: info: Removing METAVOLUMIO REST API Endpoints
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 10:31:14 volumio volumio[1018]: Cannot find translation for source QOBUZ
May 21 10:31:14 volumio volumio[1018]: info: Stopping UDEV Watcher for CD
May 21 10:31:14 volumio volumio[1018]: info: Removeing all smart Inputs
May 21 10:31:14 volumio volumio[1018]: info: Stopping AccessToken refresher cron
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 10:31:14 volumio volumio[1018]: Cannot find translation for source QOBUZ
May 21 10:31:14 volumio volumio[1018]: info: Stopping AccessToken refresher cron for QOBUZ
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 10:31:14 volumio volumio[1018]: error: Error starting TidalConnect Cannot read property 'sendRevoke' of undefined {"stack":"TypeError: Cannot read property 'sendRevoke' of undefined\n at ControllerTidalconnect.stopTidalConnect (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:8526)\n at ControllerTidalconnect.onStop (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:7780)\n at MyVolumioPluginManager.stopMyVolumioPlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:15485)\n at HashMap. (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:15286)\n at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)\n at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)\n at MyVolumioPluginManager.stopMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:15255)\n at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5788)\n at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807\n at /volumio/node_modules/v-conf/index.js:165:13"}
May 21 10:31:14 volumio qobuz-connect[3098]: 20250521 10:31:14.951 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, keeping tracks
May 21 10:31:14 volumio volumio[1018]: info: QobuzConnect: setDeactiveState invoked
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:14 volumio volumio[1018]: info: QobuzConnect: setDeactiveState(): relinquishing Volumio State
May 21 10:31:14 volumio volumio[1018]: verbose: UNSET VOLATILE: Service: qobuzconnect
May 21 10:31:14 volumio volumio[1018]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service
May 21 10:31:14 volumio volumio[1018]: info: QobuzConnect: Received stop
May 21 10:31:14 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:14 volumio qobuz-connect[3098]: 20250521 10:31:14.953 [3098.3098] INFO MediaEngine: [0xf8e7e8]: Stopping playback, keeping tracks
May 21 10:31:14 volumio sudo[3303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service
May 21 10:31:14 volumio sudo[3303]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:14 volumio volumio[1018]: info: MyVolumio status changed
May 21 10:31:14 volumio volumio[1018]: info: Streaming services startup
May 21 10:31:14 volumio volumio[1018]: info: Starting Streaming Daemon
May 21 10:31:14 volumio sudo[3303]: pam_unix(sudo:session): session closed for user root
May 21 10:31:14 volumio sudo[3306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 21 10:31:14 volumio sudo[3306]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:14 volumio volumio[1018]: info: MYVOLUMIO LOGGED OUT
May 21 10:31:14 volumio volumio[1018]: info: Removing browser output: myVolumio user plan is not superstar
May 21 10:31:14 volumio volumio[1018]: info: Removing audio output:
May 21 10:31:14 volumio volumio[1018]: info: Stoppping Tunnel 1
May 21 10:31:15 volumio sudo[3306]: pam_unix(sudo:session): session closed for user root
May 21 10:31:15 volumio sudo[3309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 21 10:31:15 volumio sudo[3309]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:15 volumio volumio[1018]: error: Cannot start Volumio Streaming Daemon
May 21 10:31:15 volumio volumio[1018]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 21 10:31:15 volumio volumio[1018]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 21 10:31:15 volumio volumio[1018]: info: Volumio BT Module successfully stopped
May 21 10:31:15 volumio autossh[1361]: received signal to exit (15)
May 21 10:31:15 volumio systemd[1]: Stopping MyVolumio SSH Tunnel...
May 21 10:31:15 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
May 21 10:31:15 volumio sudo[3312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect
May 21 10:31:15 volumio sudo[3312]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:15 volumio systemd[1]: sshtunnel.service: Succeeded.
May 21 10:31:15 volumio systemd[1]: Stopped MyVolumio SSH Tunnel.
May 21 10:31:15 volumio sudo[3309]: pam_unix(sudo:session): session closed for user root
May 21 10:31:15 volumio volumio[1018]: info: Remote SSH Stopped
May 21 10:31:15 volumio qobuz-connect[3098]: 20250521 10:31:15.065 [3098.3098] INFO CloudClient: [0xf8edc0]: Disconnecting from the cloud
May 21 10:31:15 volumio qobuz-connect[3098]: 20250521 10:31:15.065 [3098.3098] INFO CloudClient: [0xf8edc0]: Connection closed
May 21 10:31:15 volumio systemd[1]: Stopping Volumio Qobuz Connect Service...
May 21 10:31:15 volumio qobuz-connect[3098]: 20250521 10:31:15.073 [3098.3098] INFO SampleApp: Stopping Local configuration server
May 21 10:31:15 volumio qobuz-connect[3098]: 20250521 10:31:15.083 [3098.3098] INFO SampleApp: shat down connection on UNIX socket
May 21 10:31:15 volumio volumio[1018]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
May 21 10:31:15 volumio volumio[1018]: info: QobuzConnect: setDeactiveState invoked
May 21 10:31:15 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:15 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:15 volumio systemd[1]: qobuz-connect.service: Succeeded.
May 21 10:31:15 volumio systemd[1]: Stopped Volumio Qobuz Connect Service.
May 21 10:31:15 volumio sudo[3312]: pam_unix(sudo:session): session closed for user root
May 21 10:31:15 volumio volumio[1018]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket disconnected and tore down
May 21 10:31:16 volumio volumio[1018]: info: MyVolumio not started
May 21 10:31:16 volumio volumio[1018]: info: Initializing device activation check
May 21 10:31:16 volumio volumio[1018]: info: Enabling MyVolumio plan superstar via Activation Code and Device Method - Enable: b4d163289567acd271fc26c388d0d3a9
May 21 10:31:16 volumio volumio[1018]: info: Remote config written successfully
May 21 10:31:16 volumio volumio[1018]: info: MyVolumio not started
May 21 10:31:16 volumio volumio[1018]: info: Initializing device activation check
May 21 10:31:16 volumio volumio[1018]: info: Enabling MyVolumio plan superstar via Activation Code and Device Method - Enable: b4d163289567acd271fc26c388d0d3a9
May 21 10:31:17 volumio volumio[1018]: info: Remote config written successfully
May 21 10:31:17 volumio volumio[1018]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
May 21 10:31:17 volumio volumio[1018]: info: [MyVolumio PluginManager] No plugins found for user plan free
May 21 10:31:17 volumio volumio[1018]: info: [MyVolumio PluginManager] No plugins found for device plan undefined
May 21 10:31:17 volumio volumio[1018]: info: MyVolumio status changed
May 21 10:31:17 volumio volumio[1018]: info: Streaming services startup
May 21 10:31:17 volumio volumio[1018]: info: Starting Streaming Daemon
May 21 10:31:17 volumio sudo[3316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 21 10:31:17 volumio sudo[3316]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:17 volumio sudo[3316]: pam_unix(sudo:session): session closed for user root
May 21 10:31:17 volumio volumio[1018]: error: Cannot start Volumio Streaming Daemon
May 21 10:31:17 volumio volumio[1018]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 21 10:31:17 volumio volumio[1018]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 21 10:31:19 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:19 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: Listing playlists
May 21 10:31:29 volumio volumio[1018]: info: Listing playlists
May 21 10:31:29 volumio sudo[3350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 21 10:31:29 volumio sudo[3350]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:29 volumio sudo[3350]: pam_unix(sudo:session): session closed for user root
May 21 10:31:29 volumio sudo[3353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 21 10:31:29 volumio sudo[3353]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:29 volumio sudo[3353]: pam_unix(sudo:session): session closed for user root
May 21 10:31:29 volumio volumio[1018]: verbose: New Socket.io Connection to 192.168.0.4 from 192.168.0.131 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 10:31:29 volumio sudo[3356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 21 10:31:29 volumio sudo[3356]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:29 volumio sudo[3356]: pam_unix(sudo:session): session closed for user root
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 21 10:31:29 volumio sudo[3359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 21 10:31:29 volumio sudo[3359]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 10:31:29 volumio sudo[3359]: pam_unix(sudo:session): session closed for user root
May 21 10:31:29 volumio volumio[1018]: verbose: New Socket.io Connection to 192.168.0.4 from 192.168.0.131 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 21 10:31:29 volumio volumio[1018]: info: Received Get System Info
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:29 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:29 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:29 volumio volumio[1018]: info: Listing playlists
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 10:31:29 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::volumioPlay
May 21 10:31:31 volumio volumio[1018]: info: CoreStateMachine::play index undefined
May 21 10:31:31 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 10:31:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:31 volumio volumio[1018]: info: CoreStateMachine::startPlaybackTimer
May 21 10:31:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 10:31:31 volumio volumio[1018]: info: Received Get System Info
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:31 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
May 21 10:31:31 volumio volumio[1018]: info: MyVolumio login type: Token
May 21 10:31:32 volumio volumio[1018]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:32 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 10:31:32 volumio volumio[1018]: info: Received Get System Info
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 10:31:32 volumio volumio[1018]: info: Discovery: Getting this device information
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::volumioNext
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::next
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::stop
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::stPlaybackTimer
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::pushState
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::volumioGetState
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:32 volumio volumio[1018]: info: CoreStateMachine::serviceStop
May 21 10:31:32 volumio volumio[1018]: info: CorePlayQueue::getTrack 100
May 21 10:31:32 volumio volumio[1018]: info: CoreCommandRouter::serviceStop
May 21 10:31:32 volumio volumio[1018]: error: WARNING: No stop method for service qobuz
May 21 10:31:32 volumio volumio[1018]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 10:31:32 volumio volumio[1018]: TypeError: Cannot read property 'then' of undefined
May 21 10:31:32 volumio volumio[1018]: at CoreStateMachine.next (/volumio/app/statemachine.js:1177:9)
May 21 10:31:32 volumio volumio[1018]: at CoreCommandRouter.volumioNext (/volumio/app/index.js:103:28)
May 21 10:31:32 volumio volumio[1018]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:274:26)
May 21 10:31:32 volumio volumio[1018]: at Socket.emit (events.js:315:20)
May 21 10:31:32 volumio volumio[1018]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
May 21 10:31:32 volumio volumio[1018]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 21 10:31:32 volumio volumio[1018]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 10:31:33 volumio sudo[3370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 10:30
May 21 10:31:33 volumio sudo[3370]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"