-- Logs begin at Fri 2024-03-29 21:16:33 UTC, end at Tue 2024-04-02 19:37:39 UTC. -- Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioSeek Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::seek Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 16 Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: TRACKBLOCK {"uri":"qobuz://song/39775486","service":"qobuz","name":"Oceanus","title":"Oceanus","album":"Solstice","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/20/09/0060254780920_600.jpg","duration":666,"trackType":"qobuz","samplerate":"192 KHz","bitdepth":"24 bit","explicit":false,"artist":"Ralph Towner","artistUri":"qobuz://artist/37585","albumUri":"qobuz://album/0060254780920","audioQuality":"","tagImage":""} Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 16 Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: [1712086604441] ControllerQobuz::seek Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: ControllerMpd::seek Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:36:44 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: error: null Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 1 milliseconds Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 16 Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":353000,"duration":666,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5180 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=39775486&fmt=27&profile=raw&app_id=539451548&cid=2081325&etsp=1712090120&hmac=kKXcFbcTx7CqTcFKlfWD54WbfmA","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=39775486&fmt=27&profile=raw&app_id=539451548&cid=2081325&etsp=1712090120&hmac=kKXcFbcTx7CqTcFKlfWD54WbfmA","trackType":"qobuz"} Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 16 Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: ------------------------------ 19ms Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:45 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioNext Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: [1712086609728] ControllerQobuz::next Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: UNSET VOLATILE Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stPlaybackTimer Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::updateTrackBlock Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrackBlock Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 16 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::serviceStop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 16 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::serviceStop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: [1712086609732] ControllerQobuz::stop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: ControllerMpd::stop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: sendMpdCommand stop took 23 milliseconds Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::play index undefined Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: [1712086609759] ControllerQobuz::clearAddPlayTrack Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::updateTrackBlock Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrackBlock Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 14 milliseconds Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: ------------------------------ 29ms Apr 02 19:36:49 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: getStreamUrl took 407 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand stop took 2 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces system playlist update Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Ignoring MPD Status Update Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand clear took 2 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k" Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: error: updateQueue error: null Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ------------------------------ 3ms Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k" Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces system playlist update Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Ignoring MPD Status Update Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k" took 1 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand play Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ------------------------------ 5ms Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand play took 7 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 27 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 6 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":387,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1185 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","trackType":"qobuz"} Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 17 Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus stop Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ------------------------------ 59ms Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":387,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1188 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","trackType":"qobuz"} Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 17 Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: ------------------------------ 62ms Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:50 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioSeek Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::seek Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: TRACKBLOCK {"uri":"qobuz://song/29501339","service":"qobuz","name":"Chalet","title":"Chalet","album":"Wisteria","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/87/88/0060254708887_600.jpg","duration":387,"trackType":"qobuz","samplerate":"96 KHz","bitdepth":"24 bit","explicit":false,"artist":"Steve Kuhn","artistUri":"qobuz://artist/28115","albumUri":"qobuz://album/0060254708887","audioQuality":"","tagImage":""} Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: [1712086618907] ControllerQobuz::seek Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: ControllerMpd::seek Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:36:58 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: error: null Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 4 milliseconds Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":132000,"duration":387,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2523 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29501339&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090210&hmac=eptxiX_aNrgws3OpLvIf65GKo_k","trackType":"qobuz"} Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 17 Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: ------------------------------ 28ms Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:36:59 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioNext Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: [1712086620818] ControllerQobuz::next Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: UNSET VOLATILE Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stPlaybackTimer Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::updateTrackBlock Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrackBlock Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::serviceStop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 17 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::serviceStop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: [1712086620823] ControllerQobuz::stop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: ControllerMpd::stop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: sendMpdCommand stop took 26 milliseconds Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::play index undefined Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: [1712086620852] ControllerQobuz::clearAddPlayTrack Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::updateTrackBlock Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrackBlock Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 12 milliseconds Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: ------------------------------ 27ms Apr 02 19:37:00 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: getStreamUrl took 367 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand stop took 3 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand clear Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces system playlist update Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Ignoring MPD Status Update Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand clear took 2 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand load "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU" Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: error: updateQueue error: null Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ------------------------------ 4ms Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU" Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces system playlist update Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Ignoring MPD Status Update Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand add "http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU" took 1 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand play Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ------------------------------ 3ms Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand play took 3 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 25 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 18 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","trackType":"qobuz"} Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 18 Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus stop Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ------------------------------ 55ms Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 33 milliseconds Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2098 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","trackType":"qobuz"} Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 18 Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: ------------------------------ 79ms Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:01 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioSeek Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::seek Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: TRACKBLOCK {"uri":"qobuz://song/29931014","service":"qobuz","name":"Song For Sarah","title":"Song For Sarah","album":"Suspended Night","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/52/10/0060254711052_600.jpg","duration":330,"trackType":"qobuz","samplerate":"96 KHz","bitdepth":"24 bit","explicit":false,"artist":"Tomasz Stańko","artistUri":"qobuz://artist/50751","albumUri":"qobuz://album/0060254711052","audioQuality":"","tagImage":""} Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: [1712086646459] ControllerQobuz::seek Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: ControllerMpd::seek Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: error: null Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 1 milliseconds Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":75000,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2262 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","trackType":"qobuz"} Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 18 Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: ------------------------------ 19ms Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:26 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioSeek Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::seek Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: TRACKBLOCK {"uri":"qobuz://song/29931014","service":"qobuz","name":"Song For Sarah","title":"Song For Sarah","album":"Suspended Night","type":"track","tracknumber":1,"volumeNumber":1,"albumart":"https://static.qobuz.com/images/covers/52/10/0060254711052_600.jpg","duration":330,"trackType":"qobuz","samplerate":"96 KHz","bitdepth":"24 bit","explicit":false,"artist":"Tomasz Stańko","artistUri":"qobuz://artist/50751","albumUri":"qobuz://album/0060254711052","audioQuality":"","tagImage":""} Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::startPlaybackTimer Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: [1712086654677] ControllerQobuz::seek Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: ControllerMpd::seek Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Updating push state because input changed Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumiosetSourceActivempd Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: error: null Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: ---------------------------- MPD announces state update: player Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: ControllerMpd::getState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand status Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: sendMpdCommand status took 1 milliseconds Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: ControllerMpd::parseTrackInfo Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: ControllerMpd::pushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::servicePushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CorePlayQueue::getTrack 18 Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: STATE SERVICE {"status":"play","position":0,"seek":58000,"duration":330,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2730 Kbps","isStreaming":false,"title":"file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","artist":null,"album":null,"uri":"http://streaming-qobuz-std.akamaized.net:80/file?uid=1734701&eid=29931014&fmt=7&profile=raw&app_id=539451548&cid=2081325&etsp=1712090221&hmac=F6mPakfC336EB62gDmGjBRekNOU","trackType":"qobuz"} Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: verbose: CURRENT POSITION 18 Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState stateService play Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::syncState currentStatus play Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Received an update from plugin. extracting info from payload Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::pushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioPushState Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: ------------------------------ 18ms Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:34 stream-box-s2-ultra volumio[901]: info: Updating RAAT Signal Path Apr 02 19:37:37 stream-box-s2-ultra volumio[901]: info: Adding qobuz://song/29931014 to favourites with specific qobuz method Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreCommandRouter::volumioNext Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: [1712086658917] ControllerQobuz::next Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::next Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stop Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: verbose: UNSET VOLATILE Apr 02 19:37:38 stream-box-s2-ultra volumio[901]: info: CoreStateMachine::stPlaybackTimer Apr 02 19:37:38 stream-box-s2-ultra systemd-journal[26640]: Runtime journal is using 24.0M (max allowed 30.0M, trying to leave 70.4M free of 444.9M available → current limit 30.0M). Apr 02 19:37:38 stream-box-s2-ultra kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000060 Apr 02 19:37:38 stream-box-s2-ultra kernel: pgd = aee44000 Apr 02 19:37:38 stream-box-s2-ultra kernel: [00000060] *pgd=00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: Internal error: Oops: 5 [#1] SMP ARM Apr 02 19:37:38 stream-box-s2-ultra kernel: Modules linked in: xt_REDIRECT nf_nat_redirect xt_tcpudp iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack bnep ip_tables x_tables nfsd 8723bu(O) snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event cfg80211 snd_rawmidi btusb(O) btrtl(O) snd_pcm btintel(O) btbcm(O) bluetooth snd_seq snd_seq_device snd_timer evdev snd rfkill fixed bcm2835_gpiomem uio_pdrv_genirq uio i2c_dev ipv6 fuse squashfs overlay Apr 02 19:37:38 stream-box-s2-ultra kernel: CPU: 0 PID: 198 Comm: systemd-journal Tainted: G O 4.9.65-v7+ #1 Apr 02 19:37:38 stream-box-s2-ultra kernel: Hardware name: BCM2835 Apr 02 19:37:38 stream-box-s2-ultra kernel: task: aec81d80 task.stack: aed28000 Apr 02 19:37:38 stream-box-s2-ultra kernel: PC is at skb_release_head_state+0x48/0x138 Apr 02 19:37:38 stream-box-s2-ultra kernel: LR is at skb_release_all+0x1c/0x34 Apr 02 19:37:38 stream-box-s2-ultra kernel: pc : [<805ffd9c>] lr : [<80600060>] psr: 20000013 sp : aed29d40 ip : aed29d58 fp : aed29d54 Apr 02 19:37:38 stream-box-s2-ultra kernel: r10: 00000000 r9 : aed29e88 r8 : 0000004a Apr 02 19:37:38 stream-box-s2-ultra kernel: r7 : ba76a000 r6 : 806c1798 r5 : aef78180 r4 : aef78180 Apr 02 19:37:38 stream-box-s2-ultra kernel: r3 : 00000001 r2 : 60000013 r1 : bb03da80 r0 : 00000060 Apr 02 19:37:38 stream-box-s2-ultra kernel: Flags: nzCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user Apr 02 19:37:38 stream-box-s2-ultra kernel: Control: 10c5383d Table: 2ee4406a DAC: 00000055 Apr 02 19:37:38 stream-box-s2-ultra kernel: Process systemd-journal (pid: 198, stack limit = 0xaed28210) Apr 02 19:37:38 stream-box-s2-ultra kernel: Stack: (0xaed29d40 to 0xaed2a000) Apr 02 19:37:38 stream-box-s2-ultra kernel: 9d40: 00000001 aef78180 aed29d6c aed29d58 80600060 805ffd60 00000001 aed29f48 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9d60: aed29d8c aed29d70 806000dc 80600050 aed29dc4 aed29f48 00000000 aed35500 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9d80: aed29e0c aed29d90 806c1798 806000ac 00000000 aed29dc4 00004000 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9da0: aed28000 00000000 00000000 aef78180 0000001e 80c65340 0000001d aed29e48 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9dc0: aed29de4 fffffffe 00000000 aea74340 00000000 00000385 00000000 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9de0: 805f8c3c aed29f48 00000018 ba76a000 aed29e28 00000000 00004040 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9e00: aed29e1c aed29e10 805f8778 806c13d0 aed29f34 aed29e20 805f8e60 805f8760 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9e20: 00000000 00000000 00000018 00000001 00000002 00000385 00000000 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9e40: 7eaf3420 00000000 7eaf34fc 00000004 7eaf353c 00000010 007078b0 00000007 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9e60: 7eaf3504 00000007 0070d140 00000028 ffffffff 00000400 7eaf3420 62cee1bc Apr 02 19:37:38 stream-box-s2-ultra kernel: 9e80: 00000000 62cee1bc 722f0001 732f6e75 65747379 6a2f646d 6e72756f 732f6c61 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9ea0: 6f6c7379 aed20067 8026ef3c 80455e84 00000700 00000000 00000000 000002c8 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9ec0: 000081a4 00000001 00000000 00000000 00000000 00000000 00000000 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9ee0: 00000076 00000000 00000400 00000000 00000001 00000000 62cee1bc 802885ac Apr 02 19:37:38 stream-box-s2-ultra kernel: 9f00: aed29f1c aed29f10 802885ac 7eaf3428 ba76a000 00004000 00000128 80107fa4 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9f20: aed28000 00000000 aed29f94 aed29f38 805f9ba8 805f8c90 00000000 00000000 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9f40: 00000000 fffffff7 aed29e88 0000001d 00000001 00000000 00000000 aed29e70 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9f60: 00000000 00000000 aed29e28 00000018 00004040 00000000 7eaf3428 7eaf3428 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9f80: 0070cfec 76fb7f10 aed29fa4 aed29f98 805f9bf0 805f9b64 00000000 aed29fa8 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9fa0: 80107e20 805f9be4 7eaf3428 0070cfec 00000005 7eaf3428 00004000 7eaf3410 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9fc0: 7eaf3428 0070cfec 76fb7f10 00000128 7eaf3514 00000005 00000001 7eaf3504 Apr 02 19:37:38 stream-box-s2-ultra kernel: 9fe0: 00000000 7eaf33f4 004c6414 76f6f37c 60000010 00000005 e7fddef0 e7fddef0 Apr 02 19:37:38 stream-box-s2-ultra kernel: [<805ffd9c>] (skb_release_head_state) from [<80600060>] (skb_release_all+0x1c/0x34) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<80600060>] (skb_release_all) from [<806000dc>] (kfree_skb+0x3c/0xec) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<806000dc>] (kfree_skb) from [<806c1798>] (unix_dgram_sendmsg+0x3d4/0x6b4) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<806c1798>] (unix_dgram_sendmsg) from [<805f8778>] (sock_sendmsg+0x24/0x34) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<805f8778>] (sock_sendmsg) from [<805f8e60>] (___sys_sendmsg+0x1dc/0x1f0) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<805f8e60>] (___sys_sendmsg) from [<805f9ba8>] (__sys_sendmsg+0x50/0x80) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<805f9ba8>] (__sys_sendmsg) from [<805f9bf0>] (SyS_sendmsg+0x18/0x1c) Apr 02 19:37:38 stream-box-s2-ultra kernel: [<805f9bf0>] (SyS_sendmsg) from [<80107e20>] (ret_fast_syscall+0x0/0x1c) Apr 02 19:37:38 stream-box-s2-ultra kernel: Code: e3500000 0a000009 f57ff05b f590f000 (e1902f9f) Apr 02 19:37:38 stream-box-s2-ultra kernel: ---[ end trace fd88875dc41dd7d6 ]--- Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: systemd-journald.service has no holdoff time, scheduling restart. Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Stopping Journal Service... Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Starting Journal Service... Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Started Journal Service. Apr 02 19:37:38 stream-box-s2-ultra systemd-journal[26640]: Journal started Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Unit systemd-journald.service entered failed state. Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Apr 02 19:37:38 stream-box-s2-ultra systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Apr 02 19:37:39 stream-box-s2-ultra sudo[26655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-02 19:36 Apr 02 19:37:39 stream-box-s2-ultra sudo[26655]: 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"