-- Logs begin at Wed 2025-11-26 07:14:34 UTC, end at Thu 2026-01-08 16:45:35 UTC. -- Jan 08 16:44:04 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.699 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 169865 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.702 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.703 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.704 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.705 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 169865 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.705 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 190160 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.706 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.707 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 5 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.708 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 6 Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.708 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.708 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.709 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:08 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:08.709 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 169865ms Jan 08 16:44:15 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.699 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 179866 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.704 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.705 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.707 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.708 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 179866 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 190160 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 5 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 6 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.710 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.716 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 179866ms Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] DEBUG AudioRenderer: [0xab42e208]: Playback is nearly finished Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Playback is nearly finished Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 4]: Running audio stream Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] INFO UrlAudioSource: [0xab95e378]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=5666096&eid=21798627&fmt=6&profile=raw&app_id=239488056&cid=3171401&etsp=1767894075&hmac=9IfiayeiAEkIwt-ct_o8qGQFGm0 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] TRACE AudioSource: [0xab95e378]: State changed: Idle -> Running Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] DEBUG Ringbuffer: [0xab95c7f0]: Creating Audio Ringbuffer Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.857 [1998.1998] INFO ContentFetcher: [0xab55d878]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=5666096&eid=21798627&fmt=6&profile=raw&app_id=239488056&cid=3171401&etsp=1767894075&hmac=9IfiayeiAEkIwt-ct_o8qGQFGm0, offset: 0 Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.918 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Next stream changed state: Info Retrieved -> Running Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.918 [1998.1998] INFO SampleApp: [Stream 4]: New audio stream (starting from 0ms) Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.918 [1998.1998] INFO SampleApp: [Stream 4]: Stream metadata became available: Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.919 [1998.1998] INFO SampleApp: Title: Train of Tears Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.919 [1998.1998] INFO SampleApp: Artist: Friend 'N Fellow Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.919 [1998.1998] INFO SampleApp: Album: About April Jan 08 16:44:18 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:18.919 [1998.1998] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/62/66/0884463696662_600.jpg Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.579 [1998.1998] INFO UrlAudioSource: [0xab95e378]: Content info extracted Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.579 [1998.1998] INFO UrlAudioSource: [0xab95e378]: Size: 22856271 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Stream info: Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Total samples: 10937976 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Sample rate: 44100 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Channel count: 2 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Bits per sample: 16 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.586 [1998.20776] INFO AudioDecoder: [0xab444810]: Duration: 248026 Jan 08 16:44:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:19.587 [1998.1998] INFO UrlAudioSource: [0xab95e378]: Audio properties have changed Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.060 [1998.1998] TRACE AudioSource: [0xab4440d8]: State changed: Running -> Finished Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.061 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 3]: Audio stream has finished Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.061 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Current stream changed state: Running -> Finished Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.061 [1998.1998] INFO SampleApp: [Stream 3]: Audio stream finished Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.061 [1998.1998] DEBUG SampleApp: Scheduling playback nearly finished timer: 5432ms Jan 08 16:44:23 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:23.061 [1998.1998] DEBUG SampleApp: Scheduling playback finished timer for: 5932ms Jan 08 16:44:25 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:28 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:28.496 [1998.1998] INFO SampleApp: Playback is nearly finished Jan 08 16:44:28 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:28.497 [1998.1998] DEBUG SampleApp: Starting audio data flow from the next audio source to allow for gapless track transition Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: ConvSwitch: Get message: request:pause Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::volumioStop Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::stop Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::serviceStop Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::serviceStop Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: error: Could not retrieve plugin music_service qobuz_connect Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: error: WARNING: No stop method for service qobuz_connect Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: ---------------------------- Client requests Start Qobuz PlaybackRoutine Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: qobuz_connect , startQobuzPlayback Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: Qobuz Connect playback start Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Sent Meta Jan 08 16:44:28 ifi-idsd-phantom-2 node[483]: metadata.title changed Jan 08 16:44:28 ifi-idsd-phantom-2 node[483]: metadata.album: http://127.0.0.1:3000 Jan 08 16:44:28 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Get message: success Jan 08 16:44:28 ifi-idsd-phantom-2 node[483]: Download data end Jan 08 16:44:28 ifi-idsd-phantom-2 node[483]: Can't invoke metadata.sh. Error: Command failed: /usr/bin/metadata.sh /tmp/ifi-albumart Jan 08 16:44:28 ifi-idsd-phantom-2 node[483]: identify-im6.q16: no decode delegate for this image format `' @ error/constitute.c/ReadImage/560. Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: ++++--++++ search: {"type":"any","value":"BAYERN","plugin_name":"webradio","plugin_type":"music_service","uri":"radio","service":null} Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: Searching plugin music_service/webradio Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: search in webradio selection! Jan 08 16:44:29 ifi-idsd-phantom-2 node[483]: metadata.title changed Jan 08 16:44:29 ifi-idsd-phantom-2 node[483]: in qobuz-connect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.498 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 190056 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 190056 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 190160 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 5 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 6 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] INFO SampleApp: Playback has finished Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] DEBUG AudioRenderer: [0xab42e208]: Playback has finished (last track: 0) Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] DEBUG PlaybackProgressManager: [0xab42e260]: Audio playback is stopped Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE AudioRenderer: [0xab42e208]: State changed: Playing -> Track Finished Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] DEBUG AudioRenderer: [0xab42e208]: Playback initiated (after track finished playing) Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] TRACE AudioRenderer: [0xab42e208]: State changed: Track Finished -> Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.499 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.500 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.500 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.501 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Audio renderer state changed: Playing -> Track Finished Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::servicePushState Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::pushState Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::volumioPushState Jan 08 16:44:29 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.501 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 3]: Disposing of audio stream Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.501 [1998.1998] INFO ContentFetcher: [0xab444200]: Canceling download Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.501 [1998.1998] DEBUG Ringbuffer: [0xab55e348]: Freeing Audio Ringbuffer Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.502 [1998.1998] DEBUG AudioStreamInfoFetcher: [0xab460d38]: Freeing Audio Stream Info Fetcher Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.502 [1998.1998] DEBUG MetadataFetcher: [0xab539a20]: Freeing Metadata Fetcher Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.502 [1998.1998] DEBUG PlaybackUrlFetcher: [0xab585598]: Freeing Playback URL Fetcher Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.502 [1998.1998] TRACE MediaEngine: [0xab42dfe8]: State changed: Playing -> Transitioning Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.502 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 190056ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.503 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Audio renderer state changed: Track Finished -> Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] TRACE MediaEngine: [0xab42dfe8]: State changed: Transitioning -> Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Current stream changed state: Finished -> Nonexistent Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] INFO SampleApp: [Stream 3]: Audio stream has been disposed of Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] INFO StreamingEventReporter: [0xab42eb40]: Reporting streaming ended event Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: End position: 190160ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: Duration: 190160ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] DEBUG StreamingEventReporter: [0xab42eb40]: Sending streaming reports Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] INFO HttpDownloader: [0xab42eb98]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.504 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 3 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 3 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.505 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: -2 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.509 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.509 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.509 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.510 [1998.1998] DEBUG PlaybackProgressManager: [0xab42e260]: Audio playback started, time until playback gets near the end: 238018ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 9 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 9 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.513 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: -2 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.515 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.515 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.515 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.516 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending FileAudioQualityChanged message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.516 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Sample rate: 44100 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.516 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Bit depth: 16 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.516 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Channel count: 2 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.516 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Audio quality: CD Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.518 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.518 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.518 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.518 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 15 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.518 [1998.1998] INFO StreamingEventReporter: [0xab42eb40]: Reporting streaming started event Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: Track ID: 21798627 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: Start position: 15ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: Context UUID: 5d590d88-40fd-4107-a8ba-825dfa30ef44 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE StreamingEventReporter: [0xab42eb40]: Blob ID: 100000.87Gf14-XFexYj0VeX7GrgAngCZJl4XH9elYrxG4hQHtilh0RMXy_TwzZYq-spvw0.uUBRlEG4ZV00zOKPlJkCYJoBq40 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 16 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 16 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: -2 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.520 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.520 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.520 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.520 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 3ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.521 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 8ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.524 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 9ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.526 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 15ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.527 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 16ms Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.571 [1998.1998] TRACE WebsocketClient: [0xab644768]: Binary data received, size: 71 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.571 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Received SetState message: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.571 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playing state: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playback position: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Current track: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Next track: TID: 274703984, QID: 7, Context UUID: 5d590d88-40fd-4107-a8ba-825dfa30ef44 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] DEBUG MediaEngineCommandSequencer: [0xab42e360]: Enqueuing command: SetNextTrack Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Executing command: SetNextTrack Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO MediaEngine: [0xab42dfe8]: Setting next track: 274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: New stream: 5 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] DEBUG PlaybackUrlFetcher: [0xab5d4b08]: Creating Playback URL Fetcher for track: 274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO HttpDownloader: [0xab4d19a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=4d59befaafda2d2471b5cf69428a2578&request_ts=1767890669&track_id=274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] DEBUG MetadataFetcher: [0xab5855e0]: Creating Metadata Fetcher for track: 274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO HttpDownloader: [0xab57bea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] DEBUG AudioStreamInfoFetcher: [0xab57c080]: Creating Audio Stream Info Fetcher for track: 274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.572 [1998.1998] INFO HttpDownloader: [0xab57c158]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=fc885de158f327ec3d1d7d955b87767c&request_ts=1767890669&track_id=274703984 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.573 [1998.1998] DEBUG MediaEngineCommandSequencer: [0xab42e360]: Confirming command: SetNextTrack Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.636 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Next stream changed state: Nonexistent -> Created Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.636 [1998.1998] TRACE WebsocketClient: [0xab644768]: Binary data received, size: 71 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.637 [1998.1998] TRACE WebsocketClient: [0xab644768]: Binary data received, size: 71 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.870 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Received SetState message: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playing state: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playback position: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Current track: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Next track: TID: 274703984, QID: 7, Context UUID: 5d590d88-40fd-4107-a8ba-825dfa30ef44 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.871 [1998.1998] DEBUG ProtocolHandler: [0xab42e728]: Not updating next track because they are the same Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Received SetState message: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playing state: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Playback position: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Queue version: 1.1 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Current track: Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Next track: TID: 274703984, QID: 7, Context UUID: 5d590d88-40fd-4107-a8ba-825dfa30ef44 Jan 08 16:44:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:29.873 [1998.1998] DEBUG ProtocolHandler: [0xab42e728]: Not updating next track because they are the same Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.042 [1998.1998] TRACE MetadataFetcher: [0xab5855e0]: Track 274703984 doesn't have a valid work field Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.042 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 5]: Metadata became available: Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.043 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: Title: Roundabout (2024 Steven Wilson Remix) Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.043 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: Artist: Yes Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.043 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: Album: Fragile (2024 Steven Wilson Remix) Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.043 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: Album art URL: https://static.qobuz.com/images/covers/5a/5x/ff7xcq0ep5x5a_600.jpg Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.074 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 5]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5666096&eid=274703984&fmt=7&profile=raw&app_id=239488056&cid=3171401&etsp=1767894269&hmac=2bpEjYFIpndHHSD-CvRYRS1LeuY Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.074 [1998.1998] INFO AudioStreamManager: [0xab42e0d0]: [Stream 5]: stream information have been fetched Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.074 [1998.1998] DEBUG MediaEngine: [0xab42dfe8]: Next stream changed state: Created -> Info Retrieved Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.092 [1998.1998] DEBUG StreamingEventReporter: [0xab42eb40]: Streaming report submitted successfully Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.093 [1998.1998] DEBUG StreamingEventReporter: [0xab42eb40]: Sending streaming reports Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.093 [1998.1998] INFO HttpDownloader: [0xab42eb98]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jan 08 16:44:30 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:30.161 [1998.1998] DEBUG StreamingEventReporter: [0xab42eb40]: Streaming report submitted successfully Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Sent Meta Jan 08 16:44:30 ifi-idsd-phantom-2 node[483]: metadata.title changed Jan 08 16:44:30 ifi-idsd-phantom-2 node[483]: metadata.album: https://static.qobuz.com/images/covers/62/66/0884463696662_600.jpg Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Get message: success Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::servicePushState Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::pushState Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::volumioPushState Jan 08 16:44:30 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 08 16:44:30 ifi-idsd-phantom-2 node[483]: Download data end Jan 08 16:44:31 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Sent Meta Jan 08 16:44:31 ifi-idsd-phantom-2 volumio[1173]: info: MetaClient: Get message: success Jan 08 16:44:35 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.518 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 10021 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.518 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.518 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 10021 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.519 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:39 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:39.520 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 10021ms Jan 08 16:44:39 ifi-idsd-phantom-2 volumiologrotate[462]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory Jan 08 16:44:39 ifi-idsd-phantom-2 volumiologrotate[462]: ls: cannot access 'PHANTOM-2': No such file or directory Jan 08 16:44:45 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.518 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 20022 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.520 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.521 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.522 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.522 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 20022 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.523 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.524 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:49 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:49.527 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 20022ms Jan 08 16:44:55 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 30021 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 30021 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.518 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:44:59 ifi-idsd-phantom-2 play[1978]: 20260108 16:44:59.519 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 30021ms Jan 08 16:45:05 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.518 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 40022 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 40022 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.519 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:45:09 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:09.520 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 40022ms Jan 08 16:45:16 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.519 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 50023 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 50023 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.520 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:45:19 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:19.521 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 50023ms Jan 08 16:45:26 ifi-idsd-phantom-2 ethernet-detect[471]: No change in avahi-daemon interfaces. Skipping restart. Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE AudioRenderer: [0xab42e208]: Playback position: 60025 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] INFO ProtocolHandler: [0xab42e728]: Need to send state update Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] INFO QConnectMessageSender: [0xab72d490]: Sending StateUpdated message Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Playback state: Playing Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current position: 60025 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Duration: 248026 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Queue version: 1.1 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Current queue item ID: 6 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.520 [1998.1998] TRACE QConnectMessageSender: [0xab72d490]: Next queue item ID: 7 Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.521 [1998.1998] INFO QwspMessageSender: [0xab72f2a0]: Sending Payload message Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.521 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Protocol: QConnect Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.521 [1998.1998] TRACE QwspMessageSender: [0xab72f2a0]: Channel: Backend Jan 08 16:45:29 ifi-idsd-phantom-2 play[1978]: 20260108 16:45:29.521 [1998.1998] TRACE PlaybackPositionEstimator: [0xab42ecb8]: Synced playback position: 60025ms Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: ++++--++++ removeFromQueue: {"value":0} Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::volumioRemoveQueueItem Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::removeQueueItem Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::stop Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: CoreStateMachine::serviceStop Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: info: CoreCommandRouter::serviceStop Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: error: Could not retrieve plugin music_service qobuz_connect Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: error: WARNING: No stop method for service qobuz_connect Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: TypeError: Cannot read property 'then' of undefined Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at CoreStateMachine.removeQueueItem (/volumio/app/statemachine.js:1378:7) Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at CoreCommandRouter.volumioRemoveQueueItem (/volumio/app/index.js:167:28) Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:189:33) Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at Socket.emit (events.js:400:28) Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jan 08 16:45:34 ifi-idsd-phantom-2 volumio[1173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 08 16:45:35 ifi-idsd-phantom-2 sudo[23602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-08 16:44 Jan 08 16:45:35 ifi-idsd-phantom-2 sudo[23602]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="34471775a56eaef70dedee9091ea8dd3dd0bbfae" VOLUMIO_FE_VERSION="8a7c1663e5becc06293ef92fd46324fc2cb9ce6e" VOLUMIO_FE3_VERSION="c5cad6acce062070373bc18affd0d2a1a9956a16" VOLUMIO_BE_VERSION="193227560cc0f80d56df1ae05483701af415b44c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Nov 26 15:19:11 CST 2025" VOLUMIO_VERSION="2.02.2" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="6f15372e447acceb4230413af7e19e3f"