-- Logs begin at Thu 2025-10-30 19:01:46 UTC, end at Sat 2025-11-01 17:03:31 UTC. -- Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: info: Prefetching next song Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: info: [1762016539677] ControllerQobuz::prefetch Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: info: getStreamUrl took 287 milliseconds Nov 01 17:02:19 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0" Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0" Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0" took 3 milliseconds Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 3ms Nov 01 17:02:20 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand consume 1 took 2 milliseconds Nov 01 17:02:24 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::startPlaybackTimer Nov 01 17:02:24 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 3ms Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 1 milliseconds Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32,"duration":270,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2689 Kbps","isStreaming":false,"title":"file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0","trackType":"qobuz"} Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 2 Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService play Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Received an update from plugin. extracting info from payload Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 18ms Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:25 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Nov 01 17:02:26 stream-box-s2-ultra volumio[1207]: info: handleBrowseUri took 410 milliseconds Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::ClearQueue Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stop Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::updateTrackBlock Nov 01 17:02:35 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrackBlock Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::serviceStop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::serviceStop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: [1762016555985] ControllerQobuz::stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::clearPlayQueue Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::saveQueue Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::addQueueItems Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::addQueueItems Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/165774419 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/165774419 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/42670531 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/42670531 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/45789543 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/45789543 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/200999891 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/200999891 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/62008137 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/62008137 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/79749764 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/79749764 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/79749756 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/79749756 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/67902645 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/67902645 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/77476119 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/77476119 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/9853237 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/9853237 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/219953576 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/219953576 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/70704619 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/70704619 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/41896145 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/41896145 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/145095727 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/145095727 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/135007429 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/135007429 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/90522198 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/90522198 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/132290787 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/132290787 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/14785683 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/14785683 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/168182079 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/168182079 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/48912243 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/48912243 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/114457078 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/114457078 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/7651407 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/7651407 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/246154659 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/246154659 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/129239383 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/129239383 in service qobuz Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating push state because input changed Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumiosetSourceActivempd Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 475 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 504 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 492 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 488 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 478 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 527 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 488 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 505 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 501 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 506 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 523 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 518 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 513 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand stop took 597 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 3 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 2 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: 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=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=54319180&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020139&hmac=J6OzAA6rXb_Yi2OoCm1ftuzf3d0","trackType":"qobuz"} Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 2 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: No code Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 32ms Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 606 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 627 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 593 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 609 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 607 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 634 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 623 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 634 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 645 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 626 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: explodeUri took 625 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::saveQueue Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::updateTrackBlock Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrackBlock Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPlay Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::play index 1 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::play index undefined Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::startPlaybackTimer Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: [1762016556673] ControllerQobuz::clearAddPlayTrack Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: getStreamUrl took 247 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand stop took 1 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand clear took 1 milliseconds Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA" Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: error: updateQueue error: null Nov 01 17:02:36 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 2ms Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA" Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA" took 5 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand play Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 9ms Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand play took 6 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 6 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 8 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46,"duration":274,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"329 Kbps","isStreaming":false,"title":"file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","trackType":"qobuz"} Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 1 Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService play Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 23ms Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":274,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"322 Kbps","isStreaming":false,"title":"file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","trackType":"qobuz"} Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 1 Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService play Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Received an update from plugin. extracting info from payload Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 34ms Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:02:37 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::ClearQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stPlaybackTimer Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::updateTrackBlock Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrackBlock Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::serviceStop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::serviceStop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: [1762016597071] ControllerQobuz::stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::clearPlayQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::saveQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::addQueueItems Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::addQueueItems Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/165774419 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/165774419 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/42670531 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/42670531 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/45789543 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/45789543 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/200999891 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/200999891 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/62008137 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/62008137 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/79749764 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/79749764 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/79749756 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/79749756 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/67902645 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/67902645 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/77476119 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/77476119 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/9853237 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/9853237 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/219953576 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/219953576 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/70704619 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/70704619 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/41896145 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/41896145 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/145095727 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/145095727 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/135007429 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/135007429 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/90522198 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/90522198 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/132290787 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/132290787 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/14785683 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/14785683 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/168182079 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/168182079 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/48912243 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/48912243 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/114457078 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/114457078 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/7651407 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/7651407 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/246154659 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/246154659 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Adding Item to queue: qobuz://song/129239383 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Exploding uri qobuz://song/129239383 in service qobuz Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating push state because input changed Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumiosetSourceActivempd Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand stop took 184 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 1 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 1 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: 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=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=42670531&fmt=6&profile=raw&app_id=539451548&cid=3203243&etsp=1762020156&hmac=sDraEsY7_V1_bAz7869PccqsOLA","trackType":"qobuz"} Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 1 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: No code Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 22ms Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 443 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 440 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 450 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 439 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 449 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 438 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 444 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 448 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 455 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 451 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 470 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 492 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 544 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 591 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 567 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 588 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 594 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 617 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 611 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 607 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 617 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 616 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 661 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: explodeUri took 656 milliseconds Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::saveQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::updateTrackBlock Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrackBlock Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPlay Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::play index 3 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::stop Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: verbose: UNSET VOLATILE Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::play index undefined Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 3 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::startPlaybackTimer Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 3 Nov 01 17:03:17 stream-box-s2-ultra volumio[1207]: info: [1762016597770] ControllerQobuz::clearAddPlayTrack Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: getStreamUrl took 306 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand stop took 1 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand clear took 1 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE" Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: error: updateQueue error: null Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 2ms Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE" Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces system playlist update Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Ignoring MPD Status Update Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE" took 2 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand play Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 2ms Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand play took 2 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: ---------------------------- MPD announces state update: player Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 4 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::getState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand status took 6 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 3 Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE","trackType":"qobuz"} Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 3 Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService play Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 23ms Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ControllerMpd::pushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::servicePushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CorePlayQueue::getTrack 3 Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":274,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1072 Kbps","isStreaming":false,"title":"file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2943021&eid=200999891&fmt=7&profile=raw&app_id=539451548&cid=3203243&etsp=1762020198&hmac=m9o-s7PNkInSJ5BCuMY2kvqU7YE","trackType":"qobuz"} Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: verbose: CURRENT POSITION 3 Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState stateService play Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Received an update from plugin. extracting info from payload Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreStateMachine::pushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::volumioPushState Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: ------------------------------ 40ms Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:18 stream-box-s2-ultra volumio[1207]: info: Updating RAAT Signal Path Nov 01 17:03:29 stream-box-s2-ultra volumio[1207]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:03:29 stream-box-s2-ultra volumio[1207]: { Error: read ETIMEDOUT Nov 01 17:03:29 stream-box-s2-ultra volumio[1207]: at _errnoException (util.js:1022:11) Nov 01 17:03:29 stream-box-s2-ultra volumio[1207]: at TCP.onread (net.js:628:25) code: 'ETIMEDOUT', errno: 'ETIMEDOUT', syscall: 'read' } Nov 01 17:03:29 stream-box-s2-ultra volumio[1207]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:03:31 stream-box-s2-ultra sudo[26918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 17:02 Nov 01 17:03:31 stream-box-s2-ultra sudo[26918]: 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"