-- Logs begin at Tue 2024-04-09 15:47:46 UTC, end at Tue 2024-04-09 16:28:25 UTC. --
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 39 milliseconds
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 4 milliseconds
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 4
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":444,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","trackType":"qobuz"}
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 4
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 72ms
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 4
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":229,"duration":444,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2887 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","trackType":"qobuz"}
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 4
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:00 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 71ms
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::ClearQueue
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 4
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::serviceStop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 4
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::serviceStop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: [1712680027986] ControllerQobuz::stop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::stop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::clearPlayQueue
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:07 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::addQueueItems
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::addQueueItems
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623124
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623124 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623125
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623125 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623126
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623126 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623127
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623127 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623128
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623128 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623129
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623129 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623130
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623130 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623131
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623131 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623132
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623132 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623133
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623133 in service qobuz
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 256 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 235 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 277 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 250 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 252 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 11 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 273 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 4
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: 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":"file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623128&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683619&hmac=fCqzrlojfVKPRJ_FR9REZpVQPQ4","trackType":"qobuz"}
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 4
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService stop
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: No code
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 54ms
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 326 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 338 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 354 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 362 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: explodeUri took 418 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPlay
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index 6
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index undefined
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: [1712680028455] ControllerQobuz::clearAddPlayTrack
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: getStreamUrl took 363 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 1 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand clear took 2 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ"
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: error: updateQueue error: null
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 5ms
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ"
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ" took 3 milliseconds
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand play
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 6ms
Apr 09 16:27:08 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand play took 2 milliseconds
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 43 milliseconds
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 4 milliseconds
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2971 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","trackType":"qobuz"}
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 6
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 86ms
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":191,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2993 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","trackType":"qobuz"}
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 6
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:09 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 79ms
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::ClearQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::serviceStop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::serviceStop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: [1712680036172] ControllerQobuz::stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::clearPlayQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::addQueueItems
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::addQueueItems
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623124
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623124 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623125
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623125 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623126
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623126 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623127
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623127 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623128
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623128 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623129
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623129 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623130
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623130 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623131
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623131 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623132
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623132 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623133
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623133 in service qobuz
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 288 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 2 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 6
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: 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":"file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623130&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683628&hmac=UlV7jhuz189ZL5xEFm3iw78zyeQ","trackType":"qobuz"}
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 6
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: No code
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 34ms
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 302 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 318 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 307 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 342 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 387 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 388 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 393 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 387 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 563 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: explodeUri took 746 milliseconds
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPlay
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index 7
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index undefined
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:16 stream-box-s2-ultra volumio[1209]: info: [1712680036961] ControllerQobuz::clearAddPlayTrack
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: getStreamUrl took 349 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 2 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand clear took 6 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA"
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: error: updateQueue error: null
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 10ms
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA"
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA" took 4 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand play
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 7ms
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand play took 3 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 31 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","trackType":"qobuz"}
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 7
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 60ms
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 24 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":181,"duration":214,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3083 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","trackType":"qobuz"}
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 7
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:17 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 73ms
Apr 09 16:27:25 stream-box-s2-ultra volumio[1209]: info: Listing playlists
Apr 09 16:27:27 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: qobuz , explodeUri
Apr 09 16:27:28 stream-box-s2-ultra volumio[1209]: info: explodeUri took 150 milliseconds
Apr 09 16:27:28 stream-box-s2-ultra volumio[1209]: info: Saving local item Elettronica
Apr 09 16:27:28 stream-box-s2-ultra volumio[1209]: info: Pushing Favourites {"uri":"qobuz://song/38623131","favourite":false}
Apr 09 16:27:28 stream-box-s2-ultra volumio[1209]: info: Listing playlists
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::ClearQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::serviceStop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::serviceStop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: [1712680055495] ControllerQobuz::stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::clearPlayQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::addQueueItems
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::addQueueItems
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623124
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623124 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623125
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623125 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623126
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623126 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623127
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623127 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623128
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623128 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623129
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623129 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623130
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623130 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623131
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623131 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623132
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623132 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623133
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623133 in service qobuz
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 197 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 196 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 223 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 212 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 220 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 252 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 1 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 7
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: 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":"file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623131&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683637&hmac=zLYjdjUGUJYrCKI1u5lS82sVmZA","trackType":"qobuz"}
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 7
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: No code
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 40ms
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 272 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 287 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 300 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 329 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: explodeUri took 353 milliseconds
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPlay
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index 8
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index undefined
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:35 stream-box-s2-ultra volumio[1209]: info: [1712680055883] ControllerQobuz::clearAddPlayTrack
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: getStreamUrl took 321 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 1 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand clear took 6 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g"
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: error: updateQueue error: null
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 12ms
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g"
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g" took 3 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand play
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 8ms
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand play took 6 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 29 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2824 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","trackType":"qobuz"}
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 8
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 55ms
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 22 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":235,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2824 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","trackType":"qobuz"}
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 8
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:36 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 72ms
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioSeek
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::seek
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: TRACKBLOCK {"uri":"qobuz://song/38623132","service":"qobuz","name":"Step by Step","title":"Step by Step","album":"Eye In The Sky","type":"track","tracknumber":9,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/85/96/0886446379685_600.jpg","duration":235,"trackType":"qobuz","samplerate":"96 KHz","bitdepth":"24 bit","explicit":false,"artist":"The Alan Parsons Project","artistUri":"qobuz://artist/122909","albumUri":"qobuz://album/0886446379685","audioQuality":"","tagImage":""}
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: [1712680065849] ControllerQobuz::seek
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::seek
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:45 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: error: null
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 1 milliseconds
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40000,"duration":235,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3087 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","trackType":"qobuz"}
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 8
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:46 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 39ms
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::ClearQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::serviceStop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::serviceStop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: [1712680068469] ControllerQobuz::stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::clearPlayQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::addQueueItems
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::addQueueItems
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623124
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623124 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623125
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623125 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623126
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623126 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623127
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623127 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623128
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623128 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623129
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623129 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623130
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623130 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623131
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623131 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623132
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623132 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/38623133
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/38623133 in service qobuz
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 138 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 3 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 8
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: 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":"file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623132&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683656&hmac=AabUBJWzZnNxt-cfvM29E8Z6b7g","trackType":"qobuz"}
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 8
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: No code
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 40ms
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 262 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 279 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 404 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 440 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 425 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 426 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 437 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 459 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 461 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: explodeUri took 445 milliseconds
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPlay
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index 9
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index undefined
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:48 stream-box-s2-ultra volumio[1209]: info: [1712680068958] ControllerQobuz::clearAddPlayTrack
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: getStreamUrl took 344 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 1 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand clear took 4 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c"
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: error: updateQueue error: null
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 66ms
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c"
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c" took 3 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand play
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 4ms
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand play took 10 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 39 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 9 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2911 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","trackType":"qobuz"}
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 9
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 88ms
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 36 milliseconds
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":368,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2952 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","trackType":"qobuz"}
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 9
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:49 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 96ms
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioSeek
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::seek
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: TRACKBLOCK {"uri":"qobuz://song/38623133","service":"qobuz","name":"Old and Wise","title":"Old and Wise","album":"Eye In The Sky","type":"track","tracknumber":10,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/85/96/0886446379685_600.jpg","duration":298,"trackType":"qobuz","samplerate":"96 KHz","bitdepth":"24 bit","explicit":false,"artist":"The Alan Parsons Project","artistUri":"qobuz://artist/122909","albumUri":"qobuz://album/0886446379685","audioQuality":"","tagImage":""}
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: [1712680071478] ControllerQobuz::seek
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::seek
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: error: null
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 1 milliseconds
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65000,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2991 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","trackType":"qobuz"}
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 9
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:51 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 33ms
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::servicePause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: [1712680073560] ControllerQobuz::pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand pause took 21 milliseconds
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 3 milliseconds
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":66600,"duration":299,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3142 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","trackType":"qobuz"}
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 9
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus pause
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 23ms
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:27:53 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:28:08 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Apr 09 16:28:08 stream-box-s2-ultra volumio[1209]: info: handleBrowseUri took 419 milliseconds
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::ClearQueue
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stPlaybackTimer
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::serviceStop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::serviceStop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: [1712680093931] ControllerQobuz::stop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::stop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::clearPlayQueue
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::addQueueItems
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::addQueueItems
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997322
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997322 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997323
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997323 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997324
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997324 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997325
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997325 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997326
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997326 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997327
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997327 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997328
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997328 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997329
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997329 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997330
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997330 in service qobuz
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Adding Item to queue: qobuz://song/40997331
Apr 09 16:28:13 stream-box-s2-ultra volumio[1209]: info: Exploding uri qobuz://song/40997331 in service qobuz
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 109 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 4 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 9
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: 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":"file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=38623133&fmt=7&profile=raw&app_id=539451548&cid=2075646&etsp=1712683669&hmac=oz_15ZzxLlNum1Ob10XO96Zp41c","trackType":"qobuz"}
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 9
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService stop
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: No code
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 54ms
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 455 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 462 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 469 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 455 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 465 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 462 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 519 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 521 milliseconds
Apr 09 16:28:14 stream-box-s2-ultra volumio[1209]: info: explodeUri took 547 milliseconds
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: explodeUri took 1665 milliseconds
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::saveQueue
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushQueue
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::updateTrackBlock
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrackBlock
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPlay
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index 0
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::stop
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: verbose: UNSET VOLATILE
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::play index undefined
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: [1712680095612] ControllerQobuz::clearAddPlayTrack
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: getStreamUrl took 312 milliseconds
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand stop
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand stop took 3 milliseconds
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand clear
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand clear took 3 milliseconds
Apr 09 16:28:15 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4"
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: error: updateQueue error: null
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 74ms
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4"
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces system playlist update
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: Ignoring MPD Status Update
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4" took 3 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand play
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 4ms
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand play took 2 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 59 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 8 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":362,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"438 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","trackType":"qobuz"}
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 0
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus stop
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 97ms
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 28 milliseconds
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":90,"duration":362,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"438 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","trackType":"qobuz"}
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 0
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:16 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 101ms
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioSeek
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::seek
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: TRACKBLOCK {"uri":"qobuz://song/40997322","service":"qobuz","name":"I Robot","title":"I Robot","album":"I Robot","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/41/13/0886446301341_600.jpg","duration":362,"trackType":"qobuz","samplerate":"192 KHz","bitdepth":"24 bit","explicit":false,"artist":"The Alan Parsons Project","artistUri":"qobuz://artist/122909","albumUri":"qobuz://album/0886446301341","audioQuality":"","tagImage":""}
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: [1712680102286] ControllerQobuz::seek
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::seek
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: Updating push state because input changed
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumiosetSourceActivempd
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: error: null
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info:
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: ---------------------------- MPD announces state update: player
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::getState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand status
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand status took 1 milliseconds
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: ControllerMpd::parseTrackInfo
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::pushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::servicePushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61000,"duration":362,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4354 Kbps","isStreaming":false,"title":"file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=2934581&eid=40997322&fmt=27&profile=raw&app_id=539451548&cid=2075646&etsp=1712683695&hmac=9fWs0Hgt6gcZu6v1xMky0Y1ERc4","trackType":"qobuz"}
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: verbose: CURRENT POSITION 0
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState stateService play
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::syncState currentStatus play
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: Received an update from plugin. extracting info from payload
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::pushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioPushState
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 09 16:28:22 stream-box-s2-ultra volumio[1209]: info: ------------------------------ 28ms
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CoreCommandRouter::volumioSeek
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::seek
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: TRACKBLOCK {"uri":"qobuz://song/40997322","service":"qobuz","name":"I Robot","title":"I Robot","album":"I Robot","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/41/13/0886446301341_600.jpg","duration":362,"trackType":"qobuz","samplerate":"192 KHz","bitdepth":"24 bit","explicit":false,"artist":"The Alan Parsons Project","artistUri":"qobuz://artist/122909","albumUri":"qobuz://album/0886446301341","audioQuality":"","tagImage":""}
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::startPlaybackTimer
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CorePlayQueue::getTrack 0
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: [1712680104588] ControllerQobuz::seek
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 09 16:28:24 stream-box-s2-ultra volumio[1209]: info: ControllerMpd::seek
Apr 09 16:28:24 stream-box-s2-ultra systemd-journal[2498]: Runtime journal is using 8.0M (max allowed 30.0M, trying to leave 70.4M free of 460.9M available → current limit 30.0M).
Apr 09 16:28:24 stream-box-s2-ultra kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000222
Apr 09 16:28:24 stream-box-s2-ultra kernel: pgd = aee2c000
Apr 09 16:28:24 stream-box-s2-ultra kernel: [00000222] *pgd=00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: Internal error: Oops: 5 [#1] SMP ARM
Apr 09 16:28:24 stream-box-s2-ultra kernel: Modules linked in: xt_REDIRECT nf_nat_redirect bnep xt_tcpudp iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack ip_tables x_tables nfsd 8723bu(O) snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event btusb(O) btrtl(O) btintel(O) btbcm(O) snd_rawmidi cfg80211 snd_pcm bluetooth snd_seq snd_seq_device snd_timer rfkill snd bcm2835_gpiomem fixed uio_pdrv_genirq uio i2c_dev ipv6 fuse squashfs overlay
Apr 09 16:28:24 stream-box-s2-ultra kernel: CPU: 3 PID: 198 Comm: systemd-journal Tainted: G O 4.9.65-v7+ #1
Apr 09 16:28:24 stream-box-s2-ultra kernel: Hardware name: BCM2835
Apr 09 16:28:24 stream-box-s2-ultra kernel: task: ae9b8000 task.stack: aee68000
Apr 09 16:28:24 stream-box-s2-ultra kernel: PC is at skb_release_data+0x64/0x128
Apr 09 16:28:24 stream-box-s2-ultra kernel: LR is at skb_release_all+0x30/0x34
Apr 09 16:28:24 stream-box-s2-ultra kernel: pc : [<805fff80>] lr : [<80600074>] psr: 60000013
sp : aee69d78 ip : aee69d98 fp : aee69d94
Apr 09 16:28:24 stream-box-s2-ultra kernel: r10: b505a100 r9 : 00000000 r8 : 00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: r7 : 00000222 r6 : b5c2a840 r5 : b5c2a840 r4 : b5c2a840
Apr 09 16:28:24 stream-box-s2-ultra kernel: r3 : 00000000 r2 : 00000481 r1 : 00000000 r0 : b5c2a840
Apr 09 16:28:24 stream-box-s2-ultra kernel: Flags: nZCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user
Apr 09 16:28:24 stream-box-s2-ultra kernel: Control: 10c5383d Table: 2ee2c06a DAC: 00000055
Apr 09 16:28:24 stream-box-s2-ultra kernel: Process systemd-journal (pid: 198, stack limit = 0xaee68210)
Apr 09 16:28:24 stream-box-s2-ultra kernel: Stack: (0xaee69d78 to 0xaee6a000)
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9d60: b5c2a840 b5c2a840
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9d80: aee69e5c 000007de aee69dac aee69d98 80600074 805fff28 00000001 b5c2a840
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9da0: aee69dc4 aee69db0 806001f8 80600050 b5c2a840 00000022 aee69e54 aee69dc8
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9dc0: 806c2264 806001cc 00000000 00000000 b505a244 00000001 00000000 00000001
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9de0: b505a30c 00000000 b505a34c b9128700 00000022 00000001 00000022 b505a184
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9e00: aeac21c0 00000000 000004b9 000003e8 000003e8 bab6c4f8 aee69e48 8028727c
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9e20: 66156ca8 230d2b41 aee69e6c 00000000 aee69f00 aee69ee8 aee69f78 00000800
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9e40: 0196d009 00000000 aee69e84 aee69e58 806c2410 806c1b10 806bdb84 806be394
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9e60: b9128700 aee69e88 00000000 00000800 00000040 00000000 aee69ed4 aee69e88
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9e80: 805f71e0 806c23d4 00000000 00000000 00000000 00000022 000007de aee69ee0
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9ea0: 00000001 805c88c0 00000000 00000000 00000040 aee69f00 aed070ac 00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9ec0: 00000000 b5c64a80 aee69f44 aee69ed8 80268b64 805f7150 00000800 0000001d
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9ee0: 0196d009 00000800 00000000 00000000 00000800 aee69ee0 00000001 805c88c0
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9f00: b5c64a80 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9f20: 8017ea84 00000800 b5c64a80 0196d009 aee69f78 00000800 aee69f74 aee69f48
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9f40: 8026996c 80268aa0 0000002b 80289034 aee69f74 00000000 00000000 b5c64a80
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9f60: b5c64a80 00000800 aee69fa4 aee69f78 8026ab28 802698e0 00000000 00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9f80: 0196cfe0 76f34f10 7efdc738 00000003 80107fa4 aee68000 00000000 aee69fa8
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9fa0: 80107e20 8026aae8 0196cfe0 76f34f10 00000011 0196d009 00000800 00000011
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9fc0: 0196cfe0 76f34f10 7efdc738 00000003 76f34f10 019630a0 01963088 7efdca1c
Apr 09 16:28:24 stream-box-s2-ultra kernel: 9fe0: 00000000 7efdc714 004b0e78 76eebc8c 60000010 00000011 00000000 00000000
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<805fff80>] (skb_release_data) from [<80600074>] (skb_release_all+0x30/0x34)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<80600074>] (skb_release_all) from [<806001f8>] (consume_skb+0x38/0xe4)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<806001f8>] (consume_skb) from [<806c2264>] (unix_stream_read_generic+0x760/0x834)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<806c2264>] (unix_stream_read_generic) from [<806c2410>] (unix_stream_recvmsg+0x48/0x54)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<806c2410>] (unix_stream_recvmsg) from [<805f71e0>] (sock_read_iter+0x9c/0xd0)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<805f71e0>] (sock_read_iter) from [<80268b64>] (__vfs_read+0xd0/0x120)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<80268b64>] (__vfs_read) from [<8026996c>] (vfs_read+0x98/0x16c)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<8026996c>] (vfs_read) from [<8026ab28>] (SyS_read+0x4c/0xa0)
Apr 09 16:28:24 stream-box-s2-ultra kernel: [<8026ab28>] (SyS_read) from [<80107e20>] (ret_fast_syscall+0x0/0x1c)
Apr 09 16:28:24 stream-box-s2-ultra kernel: Code: 1afffffa f57ff05b e3510000 189da8f0 (e5d73000)
Apr 09 16:28:24 stream-box-s2-ultra kernel: ---[ end trace aa1cc1ea1fdba232 ]---
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: systemd-journald.service has no holdoff time, scheduling restart.
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Stopping Journal Service...
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Starting Journal Service...
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Started Journal Service.
Apr 09 16:28:24 stream-box-s2-ultra systemd-journal[2498]: Journal started
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Unit systemd-journald.service entered failed state.
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage...
Apr 09 16:28:24 stream-box-s2-ultra systemd[1]: Started Trigger Flushing of Journal to Persistent Storage.
Apr 09 16:28:25 stream-box-s2-ultra sudo[2514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-09 16:27
Apr 09 16:28:25 stream-box-s2-ultra sudo[2514]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="projectsbus2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 17:22:02 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Pro-Ject Audio Systems"
VOLUMIO_MODEL="Stream Box S2 ultra"
VOLUMIO_VENDOR_MODEL="Pro-Ject Stream Box S2 ultra"
VOLUMIO_HASH="a5127ace113e6b9fcf2a1eaed5431093"