-- Logs begin at Tue 2024-07-02 02:08:35 UTC, end at Thu 2024-07-04 22:11:55 UTC. --
Jul 04 22:10:50 stream-box-s2-ultra volumio[961]: info: Executing endpoint metavolumio
Jul 04 22:10:50 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jul 04 22:10:53 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jul 04 22:10:53 stream-box-s2-ultra volumio[961]: info: handleBrowseUri took 127 milliseconds
Jul 04 22:11:02 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jul 04 22:11:05 stream-box-s2-ultra volumio[961]: info: handleBrowseUri took 2877 milliseconds
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::ClearQueue
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stPlaybackTimer
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::updateTrackBlock
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrackBlock
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 28
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::serviceStop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 28
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::serviceStop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: [1720131094932] ControllerQobuz::stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: ControllerMpd::stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::clearPlayQueue
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::saveQueue
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushQueue
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::addQueueItems
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::addQueueItems
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: Adding Item to queue: qobuz://album/cg3tr4buyzgja
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: Exploding uri qobuz://album/cg3tr4buyzgja in service qobuz
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: Updating push state because input changed
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: sendMpdCommand stop took 39 milliseconds
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 2 milliseconds
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 28
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: 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=1670328&eid=118193430&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134143&hmac=QV4kLa8s9n1rjGGfMfXgFWS2zq4","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=118193430&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134143&hmac=QV4kLa8s9n1rjGGfMfXgFWS2zq4","trackType":"qobuz"}
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 28
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus stop
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: No code
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:34 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: ------------------------------ 23ms
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: explodeUri took 462 milliseconds
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::saveQueue
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushQueue
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::updateTrackBlock
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrackBlock
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPlay
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::play index 0
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stop
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::play index undefined
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::startPlaybackTimer
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: [1720131095408] ControllerQobuz::clearAddPlayTrack
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: getStreamUrl took 361 milliseconds
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand stop
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: sendMpdCommand stop took 2 milliseconds
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand clear
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces system playlist update
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: Ignoring MPD Status Update
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: sendMpdCommand clear took 1 milliseconds
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g"
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: error: updateQueue error: null
Jul 04 22:11:35 stream-box-s2-ultra volumio[961]: info: ------------------------------ 2ms
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g"
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces system playlist update
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info: Ignoring MPD Status Update
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g" took 1 milliseconds
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand play
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info: ------------------------------ 5ms
Jul 04 22:11:36 stream-box-s2-ultra volumio[961]: info: sendMpdCommand play took 3 milliseconds
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 10 milliseconds
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"834 Kbps","isStreaming":false,"title":"file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","trackType":"qobuz"}
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService play
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus stop
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ------------------------------ 50ms
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 31 milliseconds
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":139,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"797 Kbps","isStreaming":false,"title":"file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","trackType":"qobuz"}
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService play
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus play
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: Received an update from plugin. extracting info from payload
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:37 stream-box-s2-ultra volumio[961]: info: ------------------------------ 55ms
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stPlaybackTimer
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::servicePause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: [1720131102537] ControllerQobuz::pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: sendMpdCommand pause took 116 milliseconds
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 1 milliseconds
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5874,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"874 Kbps","isStreaming":false,"title":"file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","trackType":"qobuz"}
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus pause
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stPlaybackTimer
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: ------------------------------ 11ms
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: Updating push state because input changed
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 04 22:11:42 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::ClearQueue
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::updateTrackBlock
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrackBlock
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stPlaybackTimer
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::serviceStop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::serviceStop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: [1720131105473] ControllerQobuz::stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: ControllerMpd::stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::clearPlayQueue
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::saveQueue
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushQueue
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::addQueueItems
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::addQueueItems
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: Adding Item to queue: qobuz://album/q0mw78fbrvp4a
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: Exploding uri qobuz://album/q0mw78fbrvp4a in service qobuz
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: Updating push state because input changed
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumiosetSourceActivempd
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: sendMpdCommand stop took 29 milliseconds
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 3 milliseconds
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: 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=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=213019790&fmt=6&profile=raw&app_id=539451548&cid=1416497&etsp=1720134695&hmac=z3dam30OJdftx7_SjJC3z7y9v3g","trackType":"qobuz"}
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus stop
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: No code
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:45 stream-box-s2-ultra volumio[961]: info: ------------------------------ 22ms
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: explodeUri took 726 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::saveQueue
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushQueue
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::updateTrackBlock
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrackBlock
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPlay
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::play index 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stop
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: UNSET VOLATILE
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::play index undefined
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::startPlaybackTimer
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: [1720131106210] ControllerQobuz::clearAddPlayTrack
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: getStreamUrl took 313 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand stop
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand stop took 1 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand clear
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces system playlist update
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: Ignoring MPD Status Update
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand clear took 1 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0"
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: error: updateQueue error: null
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ------------------------------ 3ms
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0"
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces system playlist update
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: Ignoring MPD Status Update
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0" took 2 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand play
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ------------------------------ 3ms
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand play took 5 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 8 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand status
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand status took 11 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::parseTrackInfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":131,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0","trackType":"qobuz"}
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService play
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus stop
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":181,"duration":131,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1298 Kbps","isStreaming":false,"title":"file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1670328&eid=273641184&fmt=7&profile=raw&app_id=539451548&cid=1416497&etsp=1720134706&hmac=M_LUYqnOfISRZKbRAbEpffuPEq0","trackType":"qobuz"}
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: verbose: CURRENT POSITION 0
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState stateService play
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::syncState currentStatus play
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: Received an update from plugin. extracting info from payload
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPushState
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ------------------------------ 108ms
Jul 04 22:11:46 stream-box-s2-ultra volumio[961]: info: ------------------------------ 104ms
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::volumioPause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::pause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::stPlaybackTimer
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::servicePause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CorePlayQueue::getTrack 0
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreCommandRouter::servicePause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: [1720131114475] ControllerQobuz::pause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: ControllerMpd::pause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: verbose: ControllerMpd::sendMpdCommand pause
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info:
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: ---------------------------- MPD announces state update: player
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: sendMpdCommand pause took 43 milliseconds
Jul 04 22:11:54 stream-box-s2-ultra volumio[961]: info: ControllerMpd::getState
Jul 04 22:11:55 stream-box-s2-ultra sudo[18999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-04 22:10
Jul 04 22:11:55 stream-box-s2-ultra sudo[18999]: 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"