-- Logs begin at Wed 2022-07-13 15:22:02 UTC, end at Sun 2026-08-30 18:46:32 UTC. -- Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Aug 30 18:45:02 stream-box-s2-ultra sudo[8853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8853]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8857]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8857]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra sudo[8872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8872]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8853]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra sudo[8872]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra sudo[8883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8883]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8896]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8883]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra sudo[8896]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra sudo[8912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 18:45:02 stream-box-s2-ultra sudo[8912]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:02 stream-box-s2-ultra sudo[8912]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: Discovery: Getting this device information Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetState Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: Discovery: Getting this device information Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetState Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetState Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 18:45:02 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 18:45:03 stream-box-s2-ultra sudo[8927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 18:45:03 stream-box-s2-ultra sudo[8927]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:03 stream-box-s2-ultra sudo[8927]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:03 stream-box-s2-ultra sudo[8933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 18:45:03 stream-box-s2-ultra sudo[8933]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:03 stream-box-s2-ultra sudo[8933]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:03 stream-box-s2-ultra sudo[8948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 18:45:03 stream-box-s2-ultra sudo[8948]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:03 stream-box-s2-ultra sudo[8948]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:03 stream-box-s2-ultra sudo[8954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 18:45:03 stream-box-s2-ultra sudo[8954]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 18:45:03 stream-box-s2-ultra sudo[8954]: pam_unix(sudo:session): session closed for user root Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetState Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioGetQueue Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::getQueue Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getQueue Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: Listing playlists Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: error: Could not retrieve plugin audio_interface outputs Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: error: WARNING: No Audio Output plugin found Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 18:45:04 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 18:45:06 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 30 18:45:06 stream-box-s2-ultra volumio[963]: info: handleBrowseUri took 121 milliseconds Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: error: Could not retrieve plugin system_controller my_volumio Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: info: Received Get System Version Aug 30 18:45:22 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:25 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: (node:963) UnhandledPromiseRejectionWarning: Error: Start tag expected, '<' not found Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: at Object.module.exports.fromXml (/volumio/node_modules/libxmljs/lib/document.js:168:21) Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: at /volumio/app/plugins/music_service/webradio/index.js:958:31 Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: at Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: at process._tickCallback (internal/process/next_tick.js:188:7) Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: (node:963) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 1) Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: (node:963) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Aug 30 18:45:26 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 1048 milliseconds Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: Cannot compose Albumart path Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:29 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 3 Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: Prefetching next song Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: [1788115530556] ControllerQobuz::prefetch Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: getStreamUrl took 224 milliseconds Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE" Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: error: Search in plugin webradio timed out Aug 30 18:45:30 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 1312 milliseconds Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 1256 milliseconds Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 1289 milliseconds Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:31 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE" Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces system playlist update Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: Ignoring MPD Status Update Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE" took 24 milliseconds Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: ------------------------------ 5ms Aug 30 18:45:33 stream-box-s2-ultra volumio[963]: info: sendMpdCommand consume 1 took 3 milliseconds Aug 30 18:45:34 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::startPlaybackTimer Aug 30 18:45:34 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:35 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 1028 milliseconds Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 969 milliseconds Aug 30 18:45:36 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:37 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 866 milliseconds Aug 30 18:45:37 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:38 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:39 stream-box-s2-ultra volumio[963]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eddy%20Christiani/f0d8123a-9d5b-42c6-88ff-42f07bb51736.jpg' Aug 30 18:45:39 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 828 milliseconds Aug 30 18:45:39 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces system playlist update Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Ignoring MPD Status Update Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces state update: player Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: ControllerMpd::getState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand status Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: ------------------------------ 11ms Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: sendMpdCommand status took 4 milliseconds Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseTrackInfo Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: ControllerMpd::pushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::servicePushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":305,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1280 Kbps","isStreaming":false,"title":"file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE","trackType":"qobuz"} Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: verbose: CURRENT POSITION 4 Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState stateService play Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState currentStatus play Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Received an update from plugin. extracting info from payload Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: ------------------------------ 61ms Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:45:40 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:43 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 774 milliseconds Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: Searching all installed plugins Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: webradio , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin inputs Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 778 milliseconds Aug 30 18:45:44 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:45 stream-box-s2-ultra volumio[963]: info: searchQOBUZUri took 792 milliseconds Aug 30 18:45:45 stream-box-s2-ultra volumio[963]: info: All search sources collected, pushing search results Aug 30 18:45:59 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 30 18:45:59 stream-box-s2-ultra volumio[963]: info: handleBrowseUri took 299 milliseconds Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: Executing endpoint metavolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: Executing endpoint metavolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: Executing endpoint metavolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: Executing endpoint metavolumio Aug 30 18:46:00 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::ClearQueue Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: UNSET VOLATILE Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::stPlaybackTimer Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::updateTrackBlock Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrackBlock Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::serviceStop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::serviceStop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: [1788115567187] ControllerQobuz::stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: ControllerMpd::stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::clearPlayQueue Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::saveQueue Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushQueue Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::addQueueItems Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::addQueueItems Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977935 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977935 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977936 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977936 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977937 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977937 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977938 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977938 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977939 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977939 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977940 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977940 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977941 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977941 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977942 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977942 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977943 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977943 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977944 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977944 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977945 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977945 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977946 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977946 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977947 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977947 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Adding Item to queue: qobuz://song/358977948 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Exploding uri qobuz://song/358977948 in service qobuz Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating push state because input changed Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumiosetSourceActivempd Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 472 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 639 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 664 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 672 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 680 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 679 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 692 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces state update: player Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: sendMpdCommand stop took 712 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: ControllerMpd::getState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand status Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: sendMpdCommand status took 3 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseTrackInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: ControllerMpd::pushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::servicePushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 4 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=11216661&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119130&hmac=6Wj6gKIxo71rn68lwGL0FZNXUfE","trackType":"qobuz"} Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: verbose: CURRENT POSITION 4 Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState stateService stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState currentStatus stop Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: No code Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: ------------------------------ 34ms Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 729 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 720 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 715 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 741 milliseconds Aug 30 18:46:07 stream-box-s2-ultra volumio[963]: info: explodeUri took 739 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: explodeUri took 827 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: explodeUri took 890 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::saveQueue Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushQueue Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::updateTrackBlock Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrackBlock Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPlay Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: UNSET VOLATILE Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::play index 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::stop Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: UNSET VOLATILE Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::play index undefined Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::startPlaybackTimer Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: [1788115568122] ControllerQobuz::clearAddPlayTrack Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: getStreamUrl took 268 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand stop took 4 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces system playlist update Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Ignoring MPD Status Update Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand clear took 3 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g" Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: error: updateQueue error: null Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ------------------------------ 7ms Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g" Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces system playlist update Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Ignoring MPD Status Update Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g" took 2 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand play Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ------------------------------ 4ms Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand play took 3 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces state update: player Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ControllerMpd::getState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand status Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: ---------------------------- MPD announces state update: player Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand status took 24 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ControllerMpd::getState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand status Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand status took 14 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand playlistinfo took 16 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseTrackInfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ControllerMpd::pushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::servicePushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g","trackType":"qobuz"} Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: CURRENT POSITION 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState stateService play Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState currentStatus stop Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ------------------------------ 82ms Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: sendMpdCommand playlistinfo took 41 milliseconds Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: ControllerMpd::parseTrackInfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ControllerMpd::pushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::servicePushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CorePlayQueue::getTrack 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":437,"duration":270,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1171 Kbps","isStreaming":false,"title":"file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=13795132&eid=358977935&fmt=7&profile=raw&app_id=539451548&cid=4475370&etsp=1788119168&hmac=UBqYf3sJB9iEic8tFzgRFo5CN7g","trackType":"qobuz"} Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: verbose: CURRENT POSITION 0 Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState stateService play Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::syncState currentStatus play Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Received an update from plugin. extracting info from payload Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreStateMachine::pushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::volumioPushState Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: ------------------------------ 104ms Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:08 stream-box-s2-ultra volumio[963]: info: Updating RAAT Signal Path Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: TypeError: Cannot read property 'slice' of null Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at Object.onceWrapper (events.js:315:30) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at emitOne (events.js:116:13) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at ClientRequest.emit (events.js:211:7) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at TLSSocket.socketOnData (_http_client.js:440:20) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at emitOne (events.js:116:13) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at TLSSocket.emit (events.js:211:7) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at addChunk (_stream_readable.js:263:12) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at readableAddChunk (_stream_readable.js:250:11) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at TLSSocket.Readable.push (_stream_readable.js:208:10) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: at TLSWrap.onread (net.js:607:20) Aug 30 18:46:32 stream-box-s2-ultra volumio[963]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 18:46:32 stream-box-s2-ultra sudo[9363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 18:45 Aug 30 18:46:32 stream-box-s2-ultra sudo[9363]: 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"