Jan 27 23:03:00 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 157 milliseconds Jan 27 23:03:00 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 137 milliseconds Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:00 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:00 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:00 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:00 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"878 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","trackType":"qobuz"} Jan 27 23:03:00 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:00 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 27 23:03:00 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:00 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:00 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"718 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","trackType":"qobuz"} Jan 27 23:03:00 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:00 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:00 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:00 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"718 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","trackType":"qobuz"} Jan 27 23:03:00 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:00 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:00 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:00 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","trackType":"qobuz"} Jan 27 23:03:00 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:00 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:00 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:02 volumio volumio[1200]: info: ------------------------------ 3361ms Jan 27 23:03:02 volumio volumio[1200]: info: ------------------------------ 3312ms Jan 27 23:03:02 volumio volumio[1200]: info: ------------------------------ 3312ms Jan 27 23:03:02 volumio volumio[1200]: info: ------------------------------ 3140ms Jan 27 23:03:02 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 2775 milliseconds Jan 27 23:03:02 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:02 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:02 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:02 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:02 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"923 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576576&hmac=HdX1BiwBmIpyHxwBHmMuHXShv1I","trackType":"qobuz"} Jan 27 23:03:02 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:02 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:02 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:02 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:02 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:02 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:02 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:02 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:02 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:03 volumio volumio[1200]: info: ------------------------------ 3856ms Jan 27 23:03:20 volumio kernel: hwmon hwmon1: Voltage normalised Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::volumioGetState Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::volumioPlay Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::play index 6 Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::stop Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::stPlaybackTimer Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::updateTrackBlock Jan 27 23:03:38 volumio volumio[1200]: info: CorePlayQueue::getTrackBlock Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:38 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::serviceStop Jan 27 23:03:38 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:38 volumio volumio[1200]: info: CoreCommandRouter::serviceStop Jan 27 23:03:38 volumio volumio[1200]: info: [1769573018591] ControllerQobuz::stop Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 23:03:38 volumio volumio[1200]: info: ControllerMpd::stop Jan 27 23:03:38 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 23:03:38 volumio volumio[1200]: info: Jan 27 23:03:38 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:38 volumio volumio[1200]: info: sendMpdCommand stop took 184 milliseconds Jan 27 23:03:38 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:38 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::play index undefined Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:38 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:38 volumio volumio[1200]: info: CoreStateMachine::startPlaybackTimer Jan 27 23:03:38 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:38 volumio volumio[1200]: info: [1769573018824] ControllerQobuz::clearAddPlayTrack Jan 27 23:03:38 volumio volumio[1200]: info: sendMpdCommand status took 156 milliseconds Jan 27 23:03:38 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:38 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:38 volumio volumio[1200]: info: Jan 27 23:03:38 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:38 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:38 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:39 volumio volumio[1200]: info: Jan 27 23:03:39 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:39 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:39 volumio volumio[1200]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 27 23:03:39 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 164 milliseconds Jan 27 23:03:39 volumio volumio[1200]: info: sendMpdCommand status took 141 milliseconds Jan 27 23:03:39 volumio volumio[1200]: info: sendMpdCommand status took 130 milliseconds Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:39 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:39 volumio volumio[1200]: info: ------------------------------ 470ms Jan 27 23:03:39 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 279 milliseconds Jan 27 23:03:39 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 281 milliseconds Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:39 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:39 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:39 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:39 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:39 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:39 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:39 volumio volumio[1200]: info: ------------------------------ 687ms Jan 27 23:03:39 volumio volumio[1200]: info: ------------------------------ 708ms Jan 27 23:03:40 volumio volumio[1200]: info: getStreamUrl took 1539 milliseconds Jan 27 23:03:40 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 23:03:40 volumio volumio[1200]: info: sendMpdCommand stop took 34 milliseconds Jan 27 23:03:40 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand clear Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: info: sendMpdCommand clear took 18 milliseconds Jan 27 23:03:40 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328" Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 23ms Jan 27 23:03:40 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:40 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:40 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328" Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 70ms Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 68ms Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328" took 19 milliseconds Jan 27 23:03:40 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 23:03:40 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand play Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: info: Jan 27 23:03:40 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:40 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 52ms Jan 27 23:03:40 volumio volumio[1200]: info: sendMpdCommand play took 42 milliseconds Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 23ms Jan 27 23:03:40 volumio volumio[1200]: info: ------------------------------ 15ms Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 75 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: info: Jan 27 23:03:41 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 221 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 221 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 221 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 221 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 142 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand status took 75 milliseconds Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:41 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:41 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:41 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus stop Jan 27 23:03:41 volumio volumio[1200]: info: ------------------------------ 330ms Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 39 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 27 23:03:41 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 73 milliseconds Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:41 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:41 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:41 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:41 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:41 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:41 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:41 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:41 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:41 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:41 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:41 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:41 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:42 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:42 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:42 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:42 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:42 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:42 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":994,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2633 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:42 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:42 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:42 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:42 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1115,"duration":374,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2550 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=25311379&fmt=7&profile=raw&app_id=539451548&cid=1190793&etsp=1769576620&hmac=PalBEMJ-xxBHd1O57eSzwB7y328","trackType":"qobuz"} Jan 27 23:03:42 volumio volumio[1200]: verbose: CURRENT POSITION 6 Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:42 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:42 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:44 volumio volumio[1200]: info: ------------------------------ 2958ms Jan 27 23:03:44 volumio volumio[1200]: info: ------------------------------ 2954ms Jan 27 23:03:44 volumio volumio[1200]: info: ------------------------------ 3206ms Jan 27 23:03:44 volumio volumio[1200]: info: ------------------------------ 3108ms Jan 27 23:03:44 volumio volumio[1200]: info: ------------------------------ 3070ms Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::volumioGetState Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::volumioPlay Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::play index 1 Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::stop Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::stPlaybackTimer Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::updateTrackBlock Jan 27 23:03:45 volumio volumio[1200]: info: CorePlayQueue::getTrackBlock Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:45 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::serviceStop Jan 27 23:03:45 volumio volumio[1200]: info: CorePlayQueue::getTrack 6 Jan 27 23:03:45 volumio volumio[1200]: info: CoreCommandRouter::serviceStop Jan 27 23:03:45 volumio volumio[1200]: info: [1769573025818] ControllerQobuz::stop Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 23:03:45 volumio volumio[1200]: info: ControllerMpd::stop Jan 27 23:03:45 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 23:03:45 volumio volumio[1200]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 27 23:03:45 volumio volumio[1200]: info: sendMpdCommand stop took 135 milliseconds Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::play index undefined Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:03:45 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:45 volumio volumio[1200]: info: CoreStateMachine::startPlaybackTimer Jan 27 23:03:45 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:45 volumio volumio[1200]: info: [1769573025957] ControllerQobuz::clearAddPlayTrack Jan 27 23:03:45 volumio volumio[1200]: info: Jan 27 23:03:45 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:45 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:45 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:45 volumio volumio[1200]: info: Jan 27 23:03:45 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:45 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:45 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:46 volumio volumio[1200]: info: Jan 27 23:03:46 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:46 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand status took 79 milliseconds Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand status took 77 milliseconds Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand status took 35 milliseconds Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 35 milliseconds Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 35 milliseconds Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:46 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:46 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:46 volumio volumio[1200]: info: ------------------------------ 646ms Jan 27 23:03:46 volumio volumio[1200]: info: ------------------------------ 649ms Jan 27 23:03:46 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 545 milliseconds Jan 27 23:03:46 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:46 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:46 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:46 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:46 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:46 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:03:46 volumio volumio[1200]: info: ------------------------------ 952ms Jan 27 23:03:48 volumio volumio[1200]: info: getStreamUrl took 2049 milliseconds Jan 27 23:03:48 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 23:03:48 volumio volumio[1200]: info: sendMpdCommand stop took 8 milliseconds Jan 27 23:03:48 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand clear Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: info: sendMpdCommand clear took 2 milliseconds Jan 27 23:03:48 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ" Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 7ms Jan 27 23:03:48 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ" Jan 27 23:03:48 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:48 volumio volumio[1200]: error: updateQueue error: null Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 680ms Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 679ms Jan 27 23:03:48 volumio volumio[1200]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ" took 2 milliseconds Jan 27 23:03:48 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 23:03:48 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand play Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: info: Jan 27 23:03:48 volumio volumio[1200]: ---------------------------- MPD announces system playlist update Jan 27 23:03:48 volumio volumio[1200]: info: Ignoring MPD Status Update Jan 27 23:03:48 volumio volumio[1200]: info: sendMpdCommand play took 10 milliseconds Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 10ms Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 9ms Jan 27 23:03:48 volumio volumio[1200]: info: ------------------------------ 7ms Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 24 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 25 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 20 milliseconds Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 11 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 5 milliseconds Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus stop Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:49 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:49 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 83ms Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 151ms Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 151ms Jan 27 23:03:49 volumio volumio[1200]: info: Jan 27 23:03:49 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 116 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 114 milliseconds Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand status took 3 milliseconds Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:49 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:49 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 248ms Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 239ms Jan 27 23:03:49 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 345 milliseconds Jan 27 23:03:49 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:03:49 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:03:49 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:03:49 volumio volumio[1200]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":410,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"878 Kbps","isStreaming":false,"title":"file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=1616780&eid=16304049&fmt=6&profile=raw&app_id=539451548&cid=1190793&etsp=1769576627&hmac=OUz3Sy9bolh5tCgyJV-uV3gfruQ","trackType":"qobuz"} Jan 27 23:03:49 volumio volumio[1200]: verbose: CURRENT POSITION 1 Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState stateService play Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::syncState currentStatus play Jan 27 23:03:49 volumio volumio[1200]: info: Received an update from plugin. extracting info from payload Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:03:49 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:03:49 volumio volumio[1200]: info: ------------------------------ 452ms Jan 27 23:03:56 volumio kernel: hwmon hwmon1: Voltage normalised Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioGetState Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioPlay Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::play index 4 Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::stop Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::stPlaybackTimer Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::updateTrackBlock Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrackBlock Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::serviceStop Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 1 Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::serviceStop Jan 27 23:04:08 volumio volumio[1200]: info: [1769573048218] ControllerQobuz::stop Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::stop Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 23:04:08 volumio volumio[1200]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X' Jan 27 23:04:08 volumio volumio[1200]: info: Jan 27 23:04:08 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand stop took 37 milliseconds Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::play index undefined Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::startPlaybackTimer Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: [1769573048256] ControllerQobuz::clearAddPlayTrack Jan 27 23:04:08 volumio volumio[1200]: info: Jan 27 23:04:08 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:04:08 volumio volumio[1200]: info: Jan 27 23:04:08 volumio volumio[1200]: ---------------------------- MPD announces state update: player Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::getState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand status Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand status took 17 milliseconds Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand status took 16 milliseconds Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand status took 16 milliseconds Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseState Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 27 23:04:08 volumio volumio[1200]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:04:08 volumio volumio[1200]: verbose: ControllerMpd::parseTrackInfo Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:04:08 volumio volumio[1200]: info: ControllerMpd::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::servicePushState Jan 27 23:04:08 volumio volumio[1200]: info: CoreStateMachine::pushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: CoreCommandRouter::volumioPushState Jan 27 23:04:08 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:08 volumio volumio[1200]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jan 27 23:04:08 volumio volumio[1200]: info: ------------------------------ 73ms Jan 27 23:04:08 volumio volumio[1200]: info: ------------------------------ 69ms Jan 27 23:04:08 volumio volumio[1200]: info: ------------------------------ 69ms Jan 27 23:04:08 volumio volumio[1200]: info: getStreamUrl took 350 milliseconds Jan 27 23:04:08 volumio volumio[1200]: error: Could not get QOBUZ Stream URL: [object Object] Jan 27 23:04:13 volumio volumio[1200]: info: CoreCommandRouter::volumioGetState Jan 27 23:04:13 volumio volumio[1200]: info: CorePlayQueue::getTrack 4 Jan 27 23:04:16 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 23:04:16 volumio volumio[1200]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 27 23:04:19 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 27 23:04:25 volumio kernel: hwmon hwmon1: Voltage normalised Jan 27 23:04:35 volumio sudo[2671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jan 27 23:04:35 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 23:04:35 volumio sudo[2668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jan 27 23:04:35 volumio sudo[2669]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jan 27 23:04:35 volumio sudo[2669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 23:04:35 volumio sudo[2673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jan 27 23:04:35 volumio sudo[2673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 23:04:35 volumio sudo[2668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 23:04:35 volumio sudo[2668]: pam_unix(sudo:session): session closed for user root Jan 27 23:04:35 volumio volumio[1200]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jan 27 23:04:35 volumio volumio[1200]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 23:04:35 volumio volumio[1200]: TypeError: Cannot read properties of undefined (reading 'split') Jan 27 23:04:35 volumio volumio[1200]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Jan 27 23:04:35 volumio volumio[1200]: at ChildProcess.exithandler (node:child_process:413:7) Jan 27 23:04:35 volumio volumio[1200]: at ChildProcess.emit (node:events:514:28) Jan 27 23:04:35 volumio volumio[1200]: at maybeClose (node:internal/child_process:1105:16) Jan 27 23:04:35 volumio volumio[1200]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Jan 27 23:04:35 volumio volumio[1200]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 23:04:35 volumio systemd[1]: Reloading. Jan 27 23:04:36 volumio sudo[2723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-27 23:03' Jan 27 23:04:36 volumio sudo[2723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"