Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 02 17:29:00 volumio volumio[1354]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 02 17:29:00 volumio volumio[1354]: info: Received Get System Version Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 02 17:29:00 volumio volumio[1354]: info: Received Get System Info Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 02 17:29:00 volumio volumio[1354]: info: Discovery: Getting this device information Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:00 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:00 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 02 17:29:18 volumio qobuz-connect[2623]: 20261002 17:29:18.404 [2623.2628] INFO SampleApp: API endpoint invoked: get-display-info Oct 02 17:29:18 volumio qobuz-connect[2623]: 20261002 17:29:18.418 [2623.2628] INFO SampleApp: API endpoint invoked: get-connect-info Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2628] INFO SampleApp: API endpoint invoked: connect-to-qconnect Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO EndpointManager: [0x561fe4960c10]: Updating API endpoint Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO EndpointManager: [0x561fe4960c10]: Updating QConnect endpoint Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO ActiveStateManager: [0x561fe495f0f0]: Setting new active state: active Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO PlaybackSessionManager: [0x561fe49611a0]: Starting playback session maintenance Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO HttpDownloader: [0x561fe4961490]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO CloudClient: [0x561fe4961dc0]: Connecting to the cloud Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.200 [2623.2623] INFO SampleApp: Renderer is now active Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO CloudClient: [0x561fe4961dc0]: Connection established Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Authenticate message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Subscribe message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending JoinSession message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending VolumeChanged message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending VolumeMuted message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending MaxAudioQualityChanged message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.380 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetActive message: active Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Paused Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: 122140 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: 5.4 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: TID: 455578390, QID: 1, Context UUID: 3ba2cd75-1c23-45a6-9830-be9bff4f33e8 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: TID: 455578391, QID: 2, Context UUID: 3ba2cd75-1c23-45a6-9830-be9bff4f33e8 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Stopping playback, clearing tracks Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Initiating playback Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO RendererActionAvailabilityManager: [0x561fe4961ea0]: Renderer action 'Next' is available Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetLoopMode message: Off Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO PlaybackModeManager: [0x561fe4961a30]: Setting new loop mode: Off Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting current track: 455578390, initial offset: 122140ms Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Clearing all streams Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 1 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO HttpDownloader: [0x561fe4a99c00]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=57f4d34eb9c4b4f7c361cb8fb809a9a9&request_ts=1790954960&track_id=455578390 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO HttpDownloader: [0x561fe4a9b4c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=455578390 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 1]: Running audio stream Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetShuffleMode message: disabled Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO PlaybackModeManager: [0x561fe4961a30]: Setting new shuffle mode: disabled Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting next track: 455578391 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 2 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO HttpDownloader: [0x561fe4a9ccf0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=297e815a19f081ca8c3af5eb59f74cac&request_ts=1790954960&track_id=455578391 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO HttpDownloader: [0x561fe4a9e580]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=455578391 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.438 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Waiting for current stream to start before starting audio renderer Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.461 [2623.2623] INFO PlaybackSessionManager: [0x561fe49611a0]: Playback session has been refreshed Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.461 [2623.2623] INFO HttpDownloader: [0x561fe4a999a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=360f15c7dc3604309d24790af87bc2f4&request_ts=1790954960&track_id=455578390 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.461 [2623.2623] INFO HttpDownloader: [0x561fe49bf0a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=4489610500693e3bed8e6fc8c9e4ac0e&request_ts=1790954960&track_id=455578391 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.575 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578390&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958560&hmac=07hsfW6xmrqhVz_Ir3-tWYVO2J0 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.610 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 2]: Metadata became available: Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.610 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Title: September Song Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.610 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Artist: Sarah Vaughan Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.610 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album: Fall, Through Her Voice: Nina, Billie & Sarah Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.610 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album art URL: https://static.qobuz.com/images/covers/lg/9h/noiibs5g29hlg_600.jpg Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.619 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 1]: stream information have been fetched Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.619 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Starting URL audio source, initial position: 122140ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578390&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958560&hmac=07hsfW6xmrqhVz_Ir3-tWYVO2J0 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.619 [2623.2623] INFO ContentFetcher: [0x561fe4969800]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578390&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958560&hmac=07hsfW6xmrqhVz_Ir3-tWYVO2J0, offset: 0 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.619 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Starting audio renderer, initial playback state: Paused Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.619 [2623.2623] INFO SampleApp: [Stream 1]: New audio stream (starting from 122140ms) Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:20 volumio volumio[1354]: info: QobuzConnect: setActiveState() Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:20 volumio volumio[1354]: info: QobuzConnect: Set Qobuz connect default volume to 100 Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.621 [2623.2623] INFO VolumeManager: [0x561fe4961b20]: Setting new playback volume: 100 Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:20 volumio volumio[1354]: info: QobuzConnect: Stopping currently active service Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioStop Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::stop Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CorePlayQueue::getTrack 0 Oct 02 17:29:20 volumio volumio[1354]: verbose: STATE SERVICE {"status":"stop","service":"qobuzconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"qobuz","codec":"","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false} Oct 02 17:29:20 volumio volumio[1354]: verbose: CURRENT POSITION 0 Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::syncState stateService stop Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::syncState currentStatus stop Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: No code Oct 02 17:29:20 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:20 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.638+02:00 level=WARN msg="received unknown player status" component=volumio status="" Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.638+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_STOPPED positionMs= volume=100 Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.638+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=WARN msg="received unknown player status" component=volumio status="" Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_STOPPED positionMs= volume=100 Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=WARN msg="received unknown player status" component=volumio status="" Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_STOPPED positionMs= volume=100 Oct 02 17:29:20 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:20.639+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 1]: Metadata became available: Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Title: Autumn In New York Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Artist: Billie Holiday Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album: Fall, Through Her Voice: Nina, Billie & Sarah Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album art URL: https://static.qobuz.com/images/covers/lg/9h/noiibs5g29hlg_600.jpg Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO SampleApp: [Stream 1]: Stream metadata became available: Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO SampleApp: Title: Autumn In New York Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.649 [2623.2623] INFO SampleApp: Artist: Billie Holiday Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.650 [2623.2623] INFO SampleApp: Album: Fall, Through Her Voice: Nina, Billie & Sarah Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.650 [2623.2623] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/lg/9h/noiibs5g29hlg_600.jpg Oct 02 17:29:20 volumio volumio[1354]: info: QobuzConnect: setActiveState() completed, send playback confirmation Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.650 [2623.2623] INFO SampleApp: Initiating playback, initial state: Paused Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: Display-configuration --- Volumio status= timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:20 volumio volumio[1354]: info: Display-configuration --- Volumio status=undefined timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:20 volumio qobuz-connect[2623]: ALSA lib ./src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Oct 02 17:29:20 volumio qobuz-connect[2623]: ALSA lib ./src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Oct 02 17:29:20 volumio volumio[1354]: info: Display-configuration --- Volumio status=undefined timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] Undefined track duration or too short for scrobbling: undefined, 0 Oct 02 17:29:20 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: | service: undefined | duration: undefined | title: | previous title: | Initialising... Oct 02 17:29:20 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: false | timer started at: undefined Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO SampleApp: Playback state changed: Paused Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending FileAudioQualityChanged message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending DeviceAudioQualityChanged message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.656 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578391&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958560&hmac=M_bGLCsEov1KEe-xTp9g6H0Uxis Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] Undefined track duration or too short for scrobbling: undefined, 0 Oct 02 17:29:20 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: undefined | service: undefined | duration: undefined | title: undefined | previous title: | Initialising... Oct 02 17:29:20 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: false | timer started at: undefined Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:20 volumio volumio[1354]: info: [LastFM] Undefined track duration or too short for scrobbling: undefined, 0 Oct 02 17:29:20 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: undefined | service: undefined | duration: undefined | title: undefined | previous title: | Initialising... Oct 02 17:29:20 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: false | timer started at: undefined Oct 02 17:29:20 volumio volumio[1354]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.qiVTEMIr8gdjNIohCRWkoodoBd52.ccfbfed86aaee18eae4e8df6b9b8d52a.state.status' Oct 02 17:29:20 volumio volumio[1354]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.qiVTEMIr8gdjNIohCRWkoodoBd52.ccfbfed86aaee18eae4e8df6b9b8d52a.state.status' Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.764 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Content info extracted Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.764 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Size: 14181382 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Stream info: Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Total samples: 9927165 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Sample rate: 44100 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Channel count: 2 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Bits per sample: 16 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.16003] INFO AudioDecoder: [0x561fe4bed770]: Duration: 225105 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Audio properties have changed Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Seeking input stream to byte offset: 7784432 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.765 [2623.2623] INFO ContentFetcher: [0x561fe4969800]: Adjusting download offset to: 7784432 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.770 [2623.2623] INFO SampleApp: Playback volume changed: 100 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.770 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Volume changed: 100 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.770 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending VolumeChanged message Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.770 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:20 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.788 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 2]: stream information have been fetched Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.856 [2623.2623] INFO UrlAudioSource: [0x561fe496a5f0]: Seeking input stream to byte offset: 7769538 Oct 02 17:29:20 volumio qobuz-connect[2623]: 20261002 17:29:20.856 [2623.2623] INFO ContentFetcher: [0x561fe4969800]: Adjusting download offset to: 7769538 Oct 02 17:29:22 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:22 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Playing Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Resuming playback Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Resuming audio renderer Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO SampleApp: Resuming playback Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO SampleApp: Playback state changed: Playing Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO StreamingEventReporter: [0x561fe4962690]: Reporting streaming started event Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO HttpDownloader: [0x561fe4962720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.362 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.367 [2623.2623] INFO VolumeManager: [0x561fe4961b20]: Setting new playback volume: 100 Oct 02 17:29:23 volumio qobuz-connect[2623]: 20261002 17:29:23.367 [2623.2623] INFO VolumeManager: [0x561fe4961b20]: Setting new mute state: 0 Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:23 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:23 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.376+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.376+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.377+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=122140 volume=100 Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.377+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Autumn In New York" Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.378+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=122140 volume=100 Oct 02 17:29:23 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:23.378+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Autumn In New York" Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:23 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Undefined track duration or too short for scrobbling: 0, 0 Oct 02 17:29:23 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 0 | title: | previous title: | Initialising... Oct 02 17:29:23 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: false | timer started at: undefined Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:23 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 226 | title: Autumn In New York | previous title: Oct 02 17:29:23 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: false | timer started at: undefined Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Current track has sufficient metadata: title (Autumn In New York) and artist (Billie Holiday) passed on explicitly Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Updating now playing Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] starting new timer for 113000 milliseconds [Billie Holiday - Autumn In New York]. Oct 02 17:29:23 volumio volumio[1354]: -------------------------------------------------// S T A R T I N G Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Timer started with time stamp 1790954963 Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:23 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 226 | title: Autumn In New York | previous title: Autumn In New York Oct 02 17:29:23 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954963414 Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] updated "now playing" | artist: Billie Holiday | title: Autumn In New York Oct 02 17:29:23 volumio volumio[1354]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Autumn in New York","mbid":"01469b36-2d30-3ed6-a170-ea7f5deda6ff","url":"https://www.last.fm/music/Billie+Holiday/_/Autumn+in+New+York","duration":"225000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"209651","playcount":"716242","artist":{"name":"Billie Holiday","mbid":"d59c4cda-11d9-48db-8bfe-b557ee602aed","url":"https://www.last.fm/music/Billie+Holiday"},"album":{"artist":"Billie Holiday","title":"The Complete Verve Studio Master Takes","url":"https://www.last.fm/music/Billie+Holiday/The+Complete+Verve+Studio+Master+Takes","image":[{"#":"https://lastfm-img.freetls.fastly.net/i/u/34s/20507c735145a2a4d91ffe474b732b51.png","@":{"size":"small"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/64s/20507c735145a2a4d91ffe474b732b51.png","@":{"size":"medium"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/174s/20507c735145a2a4d91ffe474b732b51.png","@":{"size":"large"}},{"#":"https://lastfm-img.freetls.fastly.net/i/u/300x300/20507c735145a2a4d91ffe474b732b51.png","@":{"size":"extralarge"}}]},"userplaycount":"0","userloved":"0","toptags":""}} Oct 02 17:29:24 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:24 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:24 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:25 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:25 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:25 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:25 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:25 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:25 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:33 volumio qobuz-connect[2623]: 20261002 17:29:33.363 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:33 volumio qobuz-connect[2623]: 20261002 17:29:33.363 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:33 volumio qobuz-connect[2623]: 20261002 17:29:33.363 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:33 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:33 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:33 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:33 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:33 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:33 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:33 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:33 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:33 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:33.369+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=131397 volume=100 Oct 02 17:29:33 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:33.369+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Autumn In New York" Oct 02 17:29:33 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:33 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:33 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:33 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 226 | title: Autumn In New York | previous title: Autumn In New York Oct 02 17:29:33 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954963414 Oct 02 17:29:33 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:33 volumio volumio[1354]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 02 17:29:33 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Playing Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: 0 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: 6.1 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: TID: 440158566, QID: 0, Context UUID: 53bf6fa6-9690-4b6e-a9da-62e705790d15 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: TID: 440158567, QID: 1, Context UUID: 53bf6fa6-9690-4b6e-a9da-62e705790d15 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Stopping playback, clearing tracks Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Initiating playback Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Stopping audio renderer Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.622 [2623.2623] INFO SampleApp: Stopping playback Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.634 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Clearing all streams Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.634 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 1]: Disposing of audio stream Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.634 [2623.2623] INFO ContentFetcher: [0x561fe4969800]: Canceling download Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO SampleApp: Playback state changed: Stopped Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO StreamingEventReporter: [0x561fe4962690]: Reporting streaming ended event Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4962720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO SampleApp: [Stream 1]: Audio stream has been disposed of Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting current track: 440158566, initial offset: 0ms Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Clearing all streams Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 3 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4c326f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=97994970ebe15dfb96374f0a4de5dd78&request_ts=1790954982&track_id=440158566 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4b20e80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=440158566 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4ba48f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=a7a5e50587c2cfa8ac5eafaaf734e327&request_ts=1790954982&track_id=440158566 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 3]: Running audio stream Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting next track: 440158567 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 4 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4a99c00]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=aa64d6b4f11390204fa79c30a970263b&request_ts=1790954982&track_id=440158567 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4c13940]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=440158567 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO HttpDownloader: [0x561fe4c5b9c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=334829a8d29b021325e551ab895f1bc6&request_ts=1790954982&track_id=440158567 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.637 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Waiting for current stream to start before starting audio renderer Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.647+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=131397 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.647+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Autumn In New York" Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.658+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=0 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.658+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Autumn In New York" Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 226 | title: Autumn In New York | previous title: Autumn In New York Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954963414 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:29:42 volumio volumio[1354]: -------------------------------------------------// P A U S I N G (remaining: 93750 milliseconds) Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 226 | title: Autumn In New York | previous title: Autumn In New York Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954963414 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.726 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 3]: Metadata became available: Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.726 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Title: Mao Mao Mao Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.726 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Artist: LEENALCHI Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.726 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album: SUGUNGGA Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.726 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album art URL: https://static.qobuz.com/images/covers/ra/m2/e6k0ha99xm2ra_600.jpg Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.729 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 4]: Metadata became available: Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.729 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Title: Tiger Is Coming Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.729 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Artist: LEENALCHI Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.729 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album: SUGUNGGA Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.729 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album art URL: https://static.qobuz.com/images/covers/ra/m2/e6k0ha99xm2ra_600.jpg Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.759 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=440158566&fmt=7&profile=raw&app_id=174516466&cid=3860144&etsp=1790958582&hmac=V_p9KmOKbtxIxC1DzkRNKTy0pqc Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.772 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=440158567&fmt=7&profile=raw&app_id=174516466&cid=3860144&etsp=1790958582&hmac=QOfk4tDkKc37Yt6J6gcEp00RJZw Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.813 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 4]: stream information have been fetched Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 3]: stream information have been fetched Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO UrlAudioSource: [0x561fe4ba6fb0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=440158566&fmt=7&profile=raw&app_id=174516466&cid=3860144&etsp=1790958582&hmac=V_p9KmOKbtxIxC1DzkRNKTy0pqc Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO ContentFetcher: [0x561fe4b80720]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=440158566&fmt=7&profile=raw&app_id=174516466&cid=3860144&etsp=1790958582&hmac=V_p9KmOKbtxIxC1DzkRNKTy0pqc, offset: 0 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Starting audio renderer, initial playback state: Playing Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: [Stream 3]: Stream metadata became available: Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: Title: Mao Mao Mao Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: Artist: LEENALCHI Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: Album: SUGUNGGA Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.892 [2623.2623] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ra/m2/e6k0ha99xm2ra_600.jpg Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: QobuzConnect: alread currrent service, send playback confirmation Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.893 [2623.2623] INFO SampleApp: Initiating playback, initial state: Playing Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO SampleApp: Playback state changed: Playing Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO StreamingEventReporter: [0x561fe4962690]: Reporting streaming started event Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO HttpDownloader: [0x561fe4962720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending FileAudioQualityChanged message Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.895 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending DeviceAudioQualityChanged message Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.896 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.910+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=0 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.910+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.911+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.911+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.912+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.912+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:42 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:42 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.927+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:29:42 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:42.927+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Autumn In New York Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954963414 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Autumn In New York Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954963414 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Current track has sufficient metadata: title (Mao Mao Mao) and artist (LEENALCHI) passed on explicitly Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Updating now playing Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] starting new timer for 86000 milliseconds [LEENALCHI - Mao Mao Mao]. Oct 02 17:29:42 volumio volumio[1354]: -------------------------------------------------// S T O P P I N G Oct 02 17:29:42 volumio volumio[1354]: -------------------------------------------------// S T A R T I N G Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Timer started with time stamp 1790954982 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954982964 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:42 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:29:42 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954982964 Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:29:42 volumio volumio[1354]: info: [LastFM] Same state as the one previously pushed. No need to do anything... Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:42 volumio volumio[1354]: info: Display-configuration --- wakeupScreen: DPMS - screen on Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.2623] INFO UrlAudioSource: [0x561fe4ba6fb0]: Content info extracted Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.2623] INFO UrlAudioSource: [0x561fe4ba6fb0]: Size: 56178295 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Stream info: Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Total samples: 16502747 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Sample rate: 96000 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Channel count: 2 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Bits per sample: 24 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.16094] INFO AudioDecoder: [0x561fe4ccac90]: Duration: 171903 Oct 02 17:29:42 volumio qobuz-connect[2623]: 20261002 17:29:42.990 [2623.2623] INFO UrlAudioSource: [0x561fe4ba6fb0]: Audio properties have changed Oct 02 17:29:43 volumio volumio[1354]: info: [LastFM] updated "now playing" | artist: LEENALCHI | title: Mao Mao Mao Oct 02 17:29:43 volumio volumio[1354]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Mao Mao Mao","url":"https://www.last.fm/music/LEENALCHI/_/Mao+Mao+Mao","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"2","playcount":"2","artist":{"name":"LEENALCHI","url":"https://www.last.fm/music/LEENALCHI"},"userplaycount":"0","userloved":"0","toptags":""}} Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: 6.2 Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: Oct 02 17:29:43 volumio qobuz-connect[2623]: 20261002 17:29:43.443 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: TID: 440158567, QID: 1, Context UUID: 53bf6fa6-9690-4b6e-a9da-62e705790d15 Oct 02 17:29:44 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:44 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:44 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:44 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:44 volumio volumio[1354]: info: Executing endpoint metavolumio Oct 02 17:29:44 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Paused Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Pausing playback Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Pausing audio renderer Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO SampleApp: Pausing playback Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO SampleApp: Playback state changed: Paused Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO StreamingEventReporter: [0x561fe4962690]: Reporting streaming ended event Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO HttpDownloader: [0x561fe4962720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:29:50 volumio qobuz-connect[2623]: 20261002 17:29:50.495 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.505+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=0 volume=100 Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.505+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.506+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=8533 volume=100 Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.506+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:29:50 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:29:50 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.517+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=8533 volume=100 Oct 02 17:29:50 volumio volumio5-onboarding[2055]: time=2026-10-02T17:29:50.517+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:29:50 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:50 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:50 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:50 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:29:50 volumio volumio[1354]: info: =================> [timer] is active: true | can continue: false | timer started at: 1790954982964 Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:29:50 volumio volumio[1354]: -------------------------------------------------// P A U S I N G (remaining: 78442 milliseconds) Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:50 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:29:50 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:29:50 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:29:50 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:29:50 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:30:07 volumio ntpd[1153]: PROTO: 151.22.209.90 unlink local addr 192.168.1.244 -> Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Received SetState message: Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playing state: Playing Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Playback position: 0 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Queue version: 7.1 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Current track: TID: 455578389, QID: 0, Context UUID: 6546cf65-80a1-4192-bcde-25b35df55474 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Next track: TID: 455578390, QID: 1, Context UUID: 6546cf65-80a1-4192-bcde-25b35df55474 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Stopping playback, clearing tracks Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Initiating playback Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Stopping audio renderer Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.314 [2623.2623] INFO SampleApp: Stopping playback Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.315 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Clearing all streams Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.315 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 3]: Disposing of audio stream Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.315 [2623.2623] INFO ContentFetcher: [0x561fe4b80720]: Canceling download Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO SampleApp: Playback state changed: Stopped Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO SampleApp: [Stream 3]: Audio stream has been disposed of Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting current track: 455578389, initial offset: 0ms Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Clearing all streams Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 5 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO HttpDownloader: [0x561fe4c5e090]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=72502ffa77d03b47419721642476fb57&request_ts=1790955028&track_id=455578389 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO HttpDownloader: [0x561fe4bd1850]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=455578389 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO HttpDownloader: [0x561fe4b19380]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e9a0ec6e49a60975a53ac6f3241e486d&request_ts=1790955028&track_id=455578389 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 5]: Running audio stream Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Setting next track: 455578390 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: New stream: 6 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.316 [2623.2623] INFO HttpDownloader: [0x561fe4c25f80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=e32138bb036cd4de686d60b0a5c253df&request_ts=1790955028&track_id=455578390 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.317 [2623.2623] INFO HttpDownloader: [0x561fe4b9cba0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=455578390 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.317 [2623.2623] INFO HttpDownloader: [0x561fe4bda070]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=9c20726cd850706c8da92c5f64ac4003&request_ts=1790955028&track_id=455578390 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.317 [2623.2623] INFO MediaEngine: [0x561fe4961550]: Waiting for current stream to start before starting audio renderer Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.321+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=0 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.321+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=8533 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title="Mao Mao Mao" Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:30:28 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:30:28 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:30:28 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 172 | title: Mao Mao Mao | previous title: Mao Mao Mao Oct 02 17:30:28 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.406 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 6]: Metadata became available: Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.406 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Title: Autumn In New York Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.406 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Artist: Billie Holiday Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.406 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album: Fall, Through Her Voice: Nina, Billie & Sarah Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.406 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: Album art URL: https://static.qobuz.com/images/covers/lg/9h/noiibs5g29hlg_600.jpg Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.425 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578389&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958628&hmac=caMKaaWD4POQvKIriVuZJIK01Qg Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.432 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578390&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958628&hmac=1Jq2nkB_A3acPZJLMQit-GNXKFA Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.468 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 5]: stream information have been fetched Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.468 [2623.2623] INFO UrlAudioSource: [0x561fe4b6f930]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578389&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958628&hmac=caMKaaWD4POQvKIriVuZJIK01Qg Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.468 [2623.2623] INFO ContentFetcher: [0x561fe4b70190]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=455578389&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1790958628&hmac=caMKaaWD4POQvKIriVuZJIK01Qg, offset: 0 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.468 [2623.2623] INFO AudioRenderer: [0x561fe49617d0]: Starting audio renderer, initial playback state: Playing Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.468 [2623.2623] INFO SampleApp: [Stream 5]: New audio stream (starting from 0ms) Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: QobuzConnect: alread currrent service, send playback confirmation Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.469 [2623.2623] INFO SampleApp: Initiating playback, initial state: Playing Oct 02 17:30:28 volumio qobuz-connect[2623]: ALSA lib ./src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Oct 02 17:30:28 volumio qobuz-connect[2623]: ALSA lib ./src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO SampleApp: Playback state changed: Playing Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO StreamingEventReporter: [0x561fe4962690]: Reporting streaming started event Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO HttpDownloader: [0x561fe4962720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO ProtocolHandler: [0x561fe4961fc0]: Need to send state update Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending StateUpdated message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending FileAudioQualityChanged message Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QConnectMessageSender: [0x561fe49bfd90]: Sending DeviceAudioQualityChanged message Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.472 [2623.2623] INFO QwspMessageSender: [0x561fe4b81540]: Sending Payload message Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PAUSED positionMs=0 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.480+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::servicePushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreStateMachine::pushState Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioPushState Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output update for this device Oct 02 17:30:28 volumio volumio[1354]: info: MRS: Pushing multiroomSync output Oct 02 17:30:28 volumio volumio[1354]: info: CoreCommandRouter::volumioGetState Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.485+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" state=STATUS_PLAYING positionMs=0 volume=100 Oct 02 17:30:28 volumio volumio5-onboarding[2055]: time=2026-10-02T17:30:28.485+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.62:47804 @ 0xc0003c4b10" id= title= Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 02 17:30:28 volumio volumio[1354]: info: Display-configuration --- → Wakeup triggered Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:30:28 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 169 | title: | previous title: Mao Mao Mao Oct 02 17:30:28 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Song has been paused, so also pausing timer. Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:30:28 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 169 | title: | previous title: Mao Mao Mao Oct 02 17:30:28 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] using existing timer Oct 02 17:30:28 volumio volumio[1354]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 169 | title: undefined | previous title: Oct 02 17:30:28 volumio volumio[1354]: info: =================> [timer] is active: false | can continue: true | timer started at: 1790954982964 Oct 02 17:30:28 volumio volumio[1354]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 02 17:30:28 volumio volumio[1354]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 17:30:28 volumio volumio[1354]: TypeError: Cannot read properties of undefined (reading 'indexOf') Oct 02 17:30:28 volumio volumio[1354]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Oct 02 17:30:28 volumio volumio[1354]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Oct 02 17:30:28 volumio volumio[1354]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Oct 02 17:30:28 volumio volumio[1354]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 02 17:30:28 volumio volumio[1354]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Oct 02 17:30:28 volumio volumio[1354]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Oct 02 17:30:28 volumio volumio[1354]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 02 17:30:28 volumio volumio[1354]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 02 17:30:28 volumio volumio[1354]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Oct 02 17:30:28 volumio volumio[1354]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 02 17:30:28 volumio volumio[1354]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Oct 02 17:30:28 volumio volumio[1354]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Oct 02 17:30:28 volumio volumio[1354]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Oct 02 17:30:28 volumio volumio[1354]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 02 17:30:28 volumio volumio[1354]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 02 17:30:28 volumio volumio[1354]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Oct 02 17:30:28 volumio volumio[1354]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.530 [2623.2623] INFO AudioStreamManager: [0x561fe4961680]: [Stream 6]: stream information have been fetched Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.2623] INFO UrlAudioSource: [0x561fe4b6f930]: Content info extracted Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.2623] INFO UrlAudioSource: [0x561fe4b6f930]: Size: 17374950 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Stream info: Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Total samples: 7413504 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Sample rate: 44100 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Channel count: 2 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Bits per sample: 16 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.16227] INFO AudioDecoder: [0x561fe4baa4f0]: Duration: 168106 Oct 02 17:30:28 volumio qobuz-connect[2623]: 20261002 17:30:28.574 [2623.2623] INFO UrlAudioSource: [0x561fe4b6f930]: Audio properties have changed Oct 02 17:30:28 volumio sudo[16230]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 17:29' Oct 02 17:30:28 volumio sudo[16230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"