-- Logs begin at Fri 2025-05-16 01:36:15 CEST, end at Sun 2025-06-08 10:35:05 CEST. --
Jun 08 10:34:06 leporello volumio[3268]: info: handleBrowseUri took 10138 milliseconds
Jun 08 10:34:06 leporello volumio[3268]: error: QOBUZ Browse Error: timeout exceeded
Jun 08 10:34:06 leporello volumio[3268]: error: Failed to execute browseSource: timeout exceeded
Jun 08 10:34:15 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jun 08 10:34:17 leporello volumio[3268]: info: handleBrowseUri took 2002 milliseconds
Jun 08 10:34:17 leporello volumio[3268]: info: Preload queue cleared
Jun 08 10:34:32 leporello volumio[3268]: info: Preload queue cleared
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::ClearQueue
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::stPlaybackTimer
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::updateTrackBlock
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrackBlock
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::serviceStop
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::serviceStop
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::stop
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand stop
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::clearPlayQueue
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::saveQueue
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushQueue
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::addQueueItems
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::addQueueItems
Jun 08 10:34:32 leporello volumio[3268]: info: Preload queue cleared
Jun 08 10:34:32 leporello volumio[3268]: info: Adding Item to queue: qobuz://album/kclxygugrnp2b
Jun 08 10:34:32 leporello volumio[3268]: info: Exploding uri qobuz://album/kclxygugrnp2b in service qobuz
Jun 08 10:34:32 leporello volumio[3268]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand stop took 49 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: info:
Jun 08 10:34:32 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:32 leporello volumio[3268]: info:
Jun 08 10:34:32 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:32 leporello volumio[3268]: info:
Jun 08 10:34:32 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand status took 7 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand status took 5 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand status took 4 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Contigo en la distancia","artist":"Alejandro Saorin Martinez and Nina VES","album":"Coplas de la Luna","uri":"INTERNAL/Alejandro Saorin Martinez/Coplas de la luna/01-Contigo en la distancia.flac","trackType":"flac"}
Jun 08 10:34:32 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState stateService stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: No code
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: ------------------------------ 74ms
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 70 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 71 milliseconds
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:32 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Contigo en la distancia","artist":"Alejandro Saorin Martinez and Nina VES","album":"Coplas de la Luna","uri":"INTERNAL/Alejandro Saorin Martinez/Coplas de la luna/01-Contigo en la distancia.flac","trackType":"flac"}
Jun 08 10:34:32 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState stateService stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: No code
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Contigo en la distancia","artist":"Alejandro Saorin Martinez and Nina VES","album":"Coplas de la Luna","uri":"INTERNAL/Alejandro Saorin Martinez/Coplas de la luna/01-Contigo en la distancia.flac","trackType":"flac"}
Jun 08 10:34:32 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState stateService stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus stop
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: No code
Jun 08 10:34:32 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:32 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:32 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:32 leporello volumio[3268]: info: ------------------------------ 183ms
Jun 08 10:34:32 leporello volumio[3268]: info: ------------------------------ 182ms
Jun 08 10:34:32 leporello volumio[3268]: info: MCU Signalled Playback Inactive
Jun 08 10:34:33 leporello volumio[3268]: info: explodeUri took 1000 milliseconds
Jun 08 10:34:33 leporello volumio[3268]: info: CoreCommandRouter::volumioPushQueue
Jun 08 10:34:33 leporello volumio[3268]: info: CorePlayQueue::saveQueue
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::updateTrackBlock
Jun 08 10:34:33 leporello volumio[3268]: info: CorePlayQueue::getTrackBlock
Jun 08 10:34:33 leporello volumio[3268]: info: CoreCommandRouter::volumioPlay
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::play index 0
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::stop
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::play index undefined
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:34:33 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:33 leporello volumio[3268]: info: CoreStateMachine::startPlaybackTimer
Jun 08 10:34:33 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:33 leporello volumio[3268]: info: [1749371673092] ControllerQobuz::clearAddPlayTrack
Jun 08 10:34:33 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand stop
Jun 08 10:34:33 leporello volumio[3268]: info: sendMpdCommand stop took 8 milliseconds
Jun 08 10:34:33 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand clear
Jun 08 10:34:33 leporello volumio[3268]: info:
Jun 08 10:34:33 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:33 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:33 leporello volumio[3268]: info: sendMpdCommand clear took 2 milliseconds
Jun 08 10:34:33 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/326881387"
Jun 08 10:34:33 leporello volumio[3268]: info:
Jun 08 10:34:33 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:33 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:33 leporello volumio[3268]: info:
Jun 08 10:34:33 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:33 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:33 leporello volumio[3268]: error: updateQueue error: null
Jun 08 10:34:33 leporello volumio[3268]: info: ------------------------------ 9ms
Jun 08 10:34:33 leporello volumio[3268]: STREAMING PROXY: Handling url /?data=qobuz://song/326881387
Jun 08 10:34:33 leporello volumio[3268]: info: Executing endpoint getStreamUrlqobuz
Jun 08 10:34:33 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jun 08 10:34:33 leporello volumio[3268]: info: getStreamUrl took 699 milliseconds
Jun 08 10:34:33 leporello volumio[3268]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=326881387&fmt=7&profile=raw&app_id=539451548&cid=1234969&etsp=1749375273&hmac=gkREcg7Enohp_jOy8lGVGzwEtMU
Jun 08 10:34:34 leporello volumio[3268]: STREAMING PROXY: Response: 200, length: 37951908
Jun 08 10:34:34 leporello volumio[3268]: error: updateQueue error: null
Jun 08 10:34:34 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/326881387"
Jun 08 10:34:34 leporello volumio[3268]: info: ------------------------------ 1002ms
Jun 08 10:34:34 leporello volumio[3268]: info: ------------------------------ 1001ms
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:34 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:34 leporello volumio[3268]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/326881387" took 7 milliseconds
Jun 08 10:34:34 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 08 10:34:34 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand play
Jun 08 10:34:34 leporello volumio[3268]: STREAMING PROXY: Client dropped request, destroying
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:34 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:34 leporello volumio[3268]: STREAMING PROXY: Handling url /?data=qobuz://song/326881387
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces system playlist update
Jun 08 10:34:34 leporello volumio[3268]: info: Ignoring MPD Status Update
Jun 08 10:34:34 leporello volumio[3268]: info: ------------------------------ 25ms
Jun 08 10:34:34 leporello volumio[3268]: info: sendMpdCommand play took 18 milliseconds
Jun 08 10:34:34 leporello volumio[3268]: info: ------------------------------ 7ms
Jun 08 10:34:34 leporello volumio[3268]: info: ------------------------------ 4ms
Jun 08 10:34:34 leporello volumio[3268]: info: Executing endpoint getStreamUrlqobuz
Jun 08 10:34:34 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jun 08 10:34:34 leporello volumio[3268]: info: getStreamUrl took 657 milliseconds
Jun 08 10:34:34 leporello volumio[3268]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=326881387&fmt=7&profile=raw&app_id=539451548&cid=1234969&etsp=1749375274&hmac=Qwwojfrr0sDaC1VbeIKifqqer84
Jun 08 10:34:34 leporello volumio[3268]: STREAMING PROXY: Response: 200, length: 37951908
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:34 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:34 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:34 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:34 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:34 leporello volumio[3268]: info:
Jun 08 10:34:34 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:34 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:34 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 97 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: info:
Jun 08 10:34:35 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 107 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 105 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus stop
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 127ms
Jun 08 10:34:35 leporello volumio[3268]: info:
Jun 08 10:34:35 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:35 leporello volumio[3268]: info:
Jun 08 10:34:35 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 27 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 10 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand status took 7 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":388,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus play
Jun 08 10:34:35 leporello volumio[3268]: info: Received an update from plugin. extracting info from payload
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":393,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus play
Jun 08 10:34:35 leporello volumio[3268]: info: Received an update from plugin. extracting info from payload
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 249ms
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 249ms
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 113 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 110 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 109 milliseconds
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1106 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus play
Jun 08 10:34:35 leporello volumio[3268]: info: Received an update from plugin. extracting info from payload
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1106 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus play
Jun 08 10:34:35 leporello volumio[3268]: info: Received an update from plugin. extracting info from payload
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:34:35 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:34:35 leporello volumio[3268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":199,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1106 Kbps","isStreaming":false,"title":"326881387","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/326881387","trackType":"qobuz"}
Jun 08 10:34:35 leporello volumio[3268]: verbose: CURRENT POSITION 0
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState stateService play
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::syncState currentStatus play
Jun 08 10:34:35 leporello volumio[3268]: info: Received an update from plugin. extracting info from payload
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:34:35 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 306ms
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 287ms
Jun 08 10:34:35 leporello volumio[3268]: info: ------------------------------ 284ms
Jun 08 10:34:35 leporello volumio[3268]: info: [LastFM] Current track has sufficient metadata: title (Milky Sleep) and artist (Brian Eno) passed on explicitly
Jun 08 10:34:35 leporello volumio[3268]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare)
Jun 08 10:34:35 leporello volumio[3268]: info: Signalling Playback active due to playback status change
Jun 08 10:34:35 leporello volumio[3268]: info: MCU Signalled Playback Active
Jun 08 10:34:40 leporello volumio[3268]: STREAMING PROXY: Client dropped request, destroying
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.415 [3612.4649] INFO SampleApp: API endpoint invoked: get-connect-info
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.842 [3612.4649] INFO SampleApp: API endpoint invoked: connect-to-qconnect
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.842 [3612.3612] INFO EndpointManager: [0xac366d38]: Updating API endpoint
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.842 [3612.3612] INFO EndpointManager: [0xac366d38]: Updating QConnect endpoint
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.842 [3612.3612] INFO ActiveStateManager: [0xac365d50]: Setting new active state: active
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.842 [3612.3612] INFO PlaybackSessionManager: [0xac367128]: Starting playback session maintenance
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.843 [3612.3612] INFO HttpDownloader: [0xac367318]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.843 [3612.3612] INFO CloudClient: [0xac367998]: Connecting to the cloud
Jun 08 10:35:03 leporello qobuz-connect[3612]: 20250608 10:35:03.844 [3612.3612] INFO SampleApp: Renderer is now active
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.166 [3612.3612] INFO CloudClient: [0xac367998]: Connection established
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Authenticate message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Subscribe message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending JoinSession message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending VolumeChanged message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending VolumeMuted message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending MaxAudioQualityChanged message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.167 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Payload message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.221 [3612.3612] INFO PlaybackSessionManager: [0xac367128]: Playback session has been refreshed
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Received SetActive message: active
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Received SetState message:
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Playing state: Playing
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Playback position: 0
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Queue version: 1.1
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Current track: TID: 215032552, QID: 0, Context UUID: c5633d47-7223-42fb-82c6-3c9f1f930517
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Next track: TID: 215032553, QID: 1, Context UUID: c5633d47-7223-42fb-82c6-3c9f1f930517
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.230 [3612.3612] INFO MediaEngine: [0xac3673c0]: Stopping playback, clearing tracks
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO MediaEngine: [0xac3673c0]: Initiating playback
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO RendererActionAvailabilityManager: [0xac367a50]: Renderer action 'Next' is available
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Received SetLoopMode message: Off
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO PlaybackControlsManager: [0xac367798]: Setting new loop mode: Off
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO MediaEngine: [0xac3673c0]: Setting current track: 215032552, initial offset: 0ms
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Clearing all streams
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: New stream: 1
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO HttpDownloader: [0xac36acf0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=e55f206936c35cdb3a81a95c11163e85&request_ts=1749371704&track_id=215032552
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO HttpDownloader: [0xac373590]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=215032552
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO HttpDownloader: [0xac36da78]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=9b09a0b4b8bb54c7646bb3068c29364d&request_ts=1749371704&track_id=215032552
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 1]: Running audio stream
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.231 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Received SetShuffleMode message: disabled
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.232 [3612.3612] INFO PlaybackControlsManager: [0xac367798]: Setting new shuffle mode: disabled
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.233 [3612.3612] INFO MediaEngine: [0xac3673c0]: Setting next track: 215032553
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.233 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: New stream: 2
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.233 [3612.3612] INFO HttpDownloader: [0xac447578]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=10743627dd2e5b4069b4c6d81285e095&request_ts=1749371704&track_id=215032553
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.234 [3612.3612] INFO HttpDownloader: [0xac447270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=215032553
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.234 [3612.3612] INFO HttpDownloader: [0xac4494e8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=dc7d13501c3bfa30acb4388b5797caee&request_ts=1749371704&track_id=215032553
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.235 [3612.3612] INFO MediaEngine: [0xac3673c0]: Waiting for current stream to start before starting audio renderer
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.353 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=215032552&fmt=6&profile=raw&app_id=174516466&cid=1234969&etsp=1749375304&hmac=5i6xaBNNNzqPrcrGydgn-jsx520
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.364 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=215032553&fmt=6&profile=raw&app_id=174516466&cid=1234969&etsp=1749375304&hmac=cD43YihKEtFiwizcqsemAYXw_tQ
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.377 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 1]: stream information have been fetched
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.377 [3612.3612] INFO UrlAudioSource: [0xac5197d0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=215032552&fmt=6&profile=raw&app_id=174516466&cid=1234969&etsp=1749375304&hmac=5i6xaBNNNzqPrcrGydgn-jsx520
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.377 [3612.3612] INFO ContentFetcher: [0xac519988]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=553292&eid=215032552&fmt=6&profile=raw&app_id=174516466&cid=1234969&etsp=1749375304&hmac=5i6xaBNNNzqPrcrGydgn-jsx520, offset: 0
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.377 [3612.3612] INFO AudioRenderer: [0xac3675e0]: Starting audio renderer, initial playback state: Playing
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.377 [3612.3612] INFO SampleApp: [Stream 1]: New audio stream (starting from 0ms)
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: QobuzConnect: setActiveState()
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: QobuzConnect: Set Qobuz connect default volume to 100
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.388 [3612.3612] INFO VolumeManager: [0xac367828]: Setting new playback volume: 100
Jun 08 10:35:04 leporello volumio[3268]: info: QobuzConnect: Stopping currently active service
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioStop
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::stop
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::stPlaybackTimer
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::updateTrackBlock
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrackBlock
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::serviceStop
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::serviceStop
Jun 08 10:35:04 leporello volumio[3268]: info: [1749371704407] ControllerQobuz::stop
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::stop
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand stop
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.414 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 2]: stream information have been fetched
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand stop took 58 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect
Jun 08 10:35:04 leporello volumio[3268]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect
Jun 08 10:35:04 leporello volumio[3268]: info: QobuzConnect: setActiveState() completed, send playback confirmation
Jun 08 10:35:04 leporello volumio[3268]: info:
Jun 08 10:35:04 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:35:04 leporello volumio[3268]: info:
Jun 08 10:35:04 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:35:04 leporello volumio[3268]: info:
Jun 08 10:35:04 leporello volumio[3268]: ---------------------------- MPD announces state update: player
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::getState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand status
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.508 [3612.3612] INFO SampleApp: Initiating playback, initial state: Playing
Jun 08 10:35:04 leporello volumio[3268]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand status took 16 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand status took 14 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand status took 11 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseState
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:35:04 leporello volumio[3268]: verbose: ControllerMpd::parseTrackInfo
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd
Jun 08 10:35:04 leporello volumio[3268]: info: ControllerMpd::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CorePlayQueue::getTrack 0
Jun 08 10:35:04 leporello volumio[3268]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd
Jun 08 10:35:04 leporello volumio[3268]: info: ------------------------------ 85ms
Jun 08 10:35:04 leporello volumio[3268]: info: ------------------------------ 83ms
Jun 08 10:35:04 leporello volumio[3268]: info: ------------------------------ 81ms
Jun 08 10:35:04 leporello volumio[3268]: info: MCU Signalled Playback Inactive
Jun 08 10:35:04 leporello volumio[3268]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined
Jun 08 10:35:04 leporello volumio[3268]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined
Jun 08 10:35:04 leporello volumio[3268]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.645 [3612.3612] INFO SampleApp: Playback volume changed: 100
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.645 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Volume changed: 100
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.645 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending VolumeChanged message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.647 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Payload message
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.647 [3612.3612] INFO SampleApp: Playback state changed: Playing
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.648 [3612.3612] INFO StreamingEventReporter: [0xac367f18]: Reporting streaming started event
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.648 [3612.3612] INFO HttpDownloader: [0xac367f70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.648 [3612.3612] INFO ProtocolHandler: [0xac367b00]: Need to send state update
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.648 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending StateUpdated message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.649 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Payload message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.649 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending FileAudioQualityChanged message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.650 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Payload message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.650 [3612.3612] INFO QConnectMessageSender: [0xac3a7418]: Sending DeviceAudioQualityChanged message
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.650 [3612.3612] INFO QwspMessageSender: [0xac471980]: Sending Payload message
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.651 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 2]: Metadata became available:
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.651 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Title: Árvore de família
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Artist: as Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Album: As Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Album art URL: https://static.qobuz.com/images/covers/fb/ew/fkwdgud0cewfb_600.jpg
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: [Stream 1]: Metadata became available:
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Title: Todas as Coisas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Artist: as Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Album: As Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO AudioStreamManager: [0xac3674a8]: Album art URL: https://static.qobuz.com/images/covers/fb/ew/fkwdgud0cewfb_600.jpg
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO SampleApp: [Stream 1]: Stream metadata became available:
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO SampleApp: Title: Todas as Coisas
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO SampleApp: Artist: as Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO SampleApp: Album: As Madalenas
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.652 [3612.3612] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/fb/ew/fkwdgud0cewfb_600.jpg
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.670 [3612.3612] INFO VolumeManager: [0xac367828]: Setting new playback volume: 100
Jun 08 10:35:04 leporello qobuz-connect[3612]: 20250608 10:35:04.671 [3612.3612] INFO VolumeManager: [0xac367828]: Setting new mute state: 0
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::servicePushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreStateMachine::pushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioPushState
Jun 08 10:35:04 leporello volumio[3268]: info: CoreCommandRouter::volumioGetState
Jun 08 10:35:04 leporello volumio[3268]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title!
Jun 08 10:35:04 leporello volumio[3268]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 08 10:35:04 leporello volumio[3268]: TypeError: Cannot read property 'indexOf' of undefined
Jun 08 10:35:04 leporello volumio[3268]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25)
Jun 08 10:35:04 leporello volumio[3268]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26)
Jun 08 10:35:04 leporello volumio[3268]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52)
Jun 08 10:35:04 leporello volumio[3268]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Jun 08 10:35:04 leporello volumio[3268]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10)
Jun 08 10:35:04 leporello volumio[3268]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12)
Jun 08 10:35:04 leporello volumio[3268]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Jun 08 10:35:04 leporello volumio[3268]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Jun 08 10:35:04 leporello volumio[3268]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8)
Jun 08 10:35:04 leporello volumio[3268]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Jun 08 10:35:04 leporello volumio[3268]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20)
Jun 08 10:35:04 leporello volumio[3268]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12)
Jun 08 10:35:04 leporello volumio[3268]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16)
Jun 08 10:35:04 leporello volumio[3268]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15)
Jun 08 10:35:04 leporello volumio[3268]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20)
Jun 08 10:35:04 leporello volumio[3268]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14)
Jun 08 10:35:04 leporello volumio[3268]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.117 [3612.3612] INFO UrlAudioSource: [0xac5197d0]: Content info extracted
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.117 [3612.3612] INFO UrlAudioSource: [0xac5197d0]: Size: 23645773
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Stream info:
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Total samples: 9120468
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Sample rate: 44100
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Channel count: 2
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Bits per sample: 16
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.129 [3612.4662] INFO AudioDecoder: [0xac3709b0]: Duration: 206813
Jun 08 10:35:05 leporello qobuz-connect[3612]: 20250608 10:35:05.130 [3612.3612] INFO UrlAudioSource: [0xac5197d0]: Audio properties have changed
Jun 08 10:35:05 leporello sudo[4664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 10:34
Jun 08 10:35:05 leporello sudo[4664]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:24:39 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="c8a59422b1bfedffc72f72cef58ad20b"