-- Logs begin at Sat 2025-02-22 08:51:05 CET, end at Sat 2025-02-22 13:12:27 CET. -- Feb 22 13:11:00 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:00 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:00 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:01 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:01 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:01 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:02 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:02 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:02 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:02 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:02 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:02 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:04 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:04 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:04 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:05 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:05 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:05 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:06 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:06 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:06 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:08 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:08 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:08 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:08 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:08 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:08 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:09 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:09 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:09 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:10 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:10 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:10 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:11 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:11 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:11 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:12 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:12 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:12 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:13 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:13 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:14 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:14 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:14 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:15 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:15 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:15 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:11:17 rivo volumio[3579]: info: Discovery: Getting this device information Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:17 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:11:17 rivo volumio[3579]: info: Discovery: Getting this device information Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:17 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:11:17 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 13:11:17 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:17 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:18 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:11:18 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:11:18 rivo volumio[3579]: info: Discovery: Getting this device information Feb 22 13:11:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:18 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:18 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:11:18 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.178:3000 from 192.168.5.157 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 22 13:11:18 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 22 13:11:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:18 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:19 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 22 13:11:19 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:19 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:20 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 22 13:11:20 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:11:20 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:11:20 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:20 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:20 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:20 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:20 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:21 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:21 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:21 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:22 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:22 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:22 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:23 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:23 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:23 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:24 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:24 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:24 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:26 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:26 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:26 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:26 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:26 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:26 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:27 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:27 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:27 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:28 rivo volumio-remote-updater[2859]: No test mode Feb 22 13:11:28 rivo volumio-remote-updater[2859]: No alpha test mode Feb 22 13:11:28 rivo volumio[3579]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 22 13:11:28 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 22 13:11:28 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:28 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:28 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:29 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:29 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:29 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:29 rivo volumio[3579]: info: CoreCommandRouter::Close All Modals sent Feb 22 13:11:30 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:30 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:30 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:30 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:31 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:31 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:32 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:32 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:32 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:32 rivo volumio[3579]: info: CoreCommandRouter::volumioPlay Feb 22 13:11:32 rivo volumio[3579]: info: CoreStateMachine::play index undefined Feb 22 13:11:32 rivo volumio[3579]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 13:11:32 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:32 rivo volumio[3579]: info: CoreStateMachine::startPlaybackTimer Feb 22 13:11:32 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:32 rivo volumio[3579]: info: [1740226292678] ControllerQobuz::clearAddPlayTrack Feb 22 13:11:32 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 13:11:32 rivo volumio[3579]: info: sendMpdCommand stop took 4 milliseconds Feb 22 13:11:32 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 13:11:32 rivo volumio[3579]: info: Feb 22 13:11:32 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:32 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:32 rivo volumio[3579]: info: sendMpdCommand clear took 3 milliseconds Feb 22 13:11:32 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/285684854" Feb 22 13:11:32 rivo volumio[3579]: info: Feb 22 13:11:32 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:32 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:32 rivo volumio[3579]: STREAMING PROXY: Handling url /?data=qobuz://song/285684854 Feb 22 13:11:32 rivo volumio[3579]: info: Feb 22 13:11:32 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:32 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:32 rivo volumio[3579]: error: updateQueue error: null Feb 22 13:11:32 rivo volumio[3579]: info: ------------------------------ 17ms Feb 22 13:11:32 rivo volumio[3579]: error: Upnp client error: Error: This socket has been ended by the other party Feb 22 13:11:32 rivo volumio[3579]: info: Executing endpoint getStreamUrlqobuz Feb 22 13:11:32 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 22 13:11:33 rivo volumio[3579]: info: getStreamUrl took 527 milliseconds Feb 22 13:11:33 rivo volumio[3579]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3584983&eid=285684854&fmt=7&profile=raw&app_id=539451548&cid=2556276&etsp=1740229893&hmac=RF2gQFYsifGA-eRw4MjPhRKfj58 Feb 22 13:11:33 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:33 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:33 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:33 rivo volumio[3579]: STREAMING PROXY: Response: 200, length: 10580640 Feb 22 13:11:33 rivo volumio[3579]: STREAMING PROXY: Client dropped request, destroying Feb 22 13:11:33 rivo volumio[3579]: error: updateQueue error: null Feb 22 13:11:33 rivo volumio[3579]: error: updateQueue error: null Feb 22 13:11:33 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/285684854" Feb 22 13:11:33 rivo volumio[3579]: info: ------------------------------ 1269ms Feb 22 13:11:33 rivo volumio[3579]: info: ------------------------------ 1262ms Feb 22 13:11:33 rivo volumio[3579]: info: Feb 22 13:11:33 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:33 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:33 rivo volumio[3579]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/285684854" took 3 milliseconds Feb 22 13:11:33 rivo volumio[3579]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 13:11:33 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand play Feb 22 13:11:33 rivo volumio[3579]: info: Feb 22 13:11:33 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:33 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:33 rivo volumio[3579]: info: Feb 22 13:11:33 rivo volumio[3579]: ---------------------------- MPD announces system playlist update Feb 22 13:11:33 rivo volumio[3579]: info: Ignoring MPD Status Update Feb 22 13:11:33 rivo volumio[3579]: STREAMING PROXY: Handling url /?data=qobuz://song/285684854 Feb 22 13:11:33 rivo volumio[3579]: info: ------------------------------ 8ms Feb 22 13:11:33 rivo volumio[3579]: info: sendMpdCommand play took 7 milliseconds Feb 22 13:11:33 rivo volumio[3579]: info: ------------------------------ 6ms Feb 22 13:11:33 rivo volumio[3579]: info: ------------------------------ 4ms Feb 22 13:11:33 rivo volumio[3579]: info: Executing endpoint getStreamUrlqobuz Feb 22 13:11:33 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 22 13:11:34 rivo volumio[3579]: info: getStreamUrl took 423 milliseconds Feb 22 13:11:34 rivo volumio[3579]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=3584983&eid=285684854&fmt=7&profile=raw&app_id=539451548&cid=2556276&etsp=1740229894&hmac=0A9vNFvUmodwDofnglHfnlLBUbs Feb 22 13:11:34 rivo volumio[3579]: STREAMING PROXY: Response: 200, length: 10580640 Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 34 milliseconds Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 38 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 38 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus stop Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 61ms Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: Feb 22 13:11:34 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 25 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 5 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand status took 4 milliseconds Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus play Feb 22 13:11:34 rivo volumio[3579]: info: Received an update from plugin. extracting info from payload Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus play Feb 22 13:11:34 rivo volumio[3579]: info: Received an update from plugin. extracting info from payload Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 140ms Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 140ms Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 76 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 74 milliseconds Feb 22 13:11:34 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 73 milliseconds Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus play Feb 22 13:11:34 rivo volumio[3579]: info: Received an update from plugin. extracting info from payload Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus play Feb 22 13:11:34 rivo volumio[3579]: info: Received an update from plugin. extracting info from payload Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:11:34 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:11:34 rivo volumio[3579]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:11:34 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState stateService play Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus play Feb 22 13:11:34 rivo volumio[3579]: info: Received an update from plugin. extracting info from payload Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:11:34 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:11:34 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 185ms Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 166ms Feb 22 13:11:34 rivo volumio[3579]: info: ------------------------------ 165ms Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:34 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:11:35 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:35 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:36 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:36 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:37 rivo volumio[3579]: STREAMING PROXY: Client dropped request, destroying Feb 22 13:11:37 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:37 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:38 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:38 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:39 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:39 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:40 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:40 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:41 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:11:41 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:11:41 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:11:41 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:11:41 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:11:41 rivo volumio[3579]: info: Listing playlists Feb 22 13:11:41 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:41 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:42 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 13:11:42 rivo volumio[3579]: info: CURURI: music-library Feb 22 13:11:42 rivo volumio[3579]: info: Preload queue cleared Feb 22 13:11:42 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:42 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:44 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:44 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:44 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 13:11:44 rivo volumio[3579]: info: CURURI: music-library/INTERNAL Feb 22 13:11:44 rivo volumio[3579]: info: Preload queue cleared Feb 22 13:11:44 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:45 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:45 rivo volumio[3579]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Feb 22 13:11:45 rivo volumio[3579]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Feb 22 13:11:45 rivo volumio[3579]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Feb 22 13:11:45 rivo volumio[3579]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Feb 22 13:11:45 rivo volumio[3579]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Feb 22 13:11:45 rivo volumio[3579]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Feb 22 13:11:45 rivo volumio[3579]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 22 13:11:45 rivo volumio[3579]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 22 13:11:46 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:46 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:47 rivo volumio[3579]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Feb 22 13:11:47 rivo volumio[3579]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Feb 22 13:11:47 rivo volumio[3579]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Feb 22 13:11:47 rivo volumio[3579]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Feb 22 13:11:47 rivo volumio[3579]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Feb 22 13:11:47 rivo volumio[3579]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Feb 22 13:11:47 rivo volumio[3579]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 22 13:11:47 rivo volumio[3579]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 22 13:11:47 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:47 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:47 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:11:47 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:11:47 rivo volumio[3579]: info: Discovery: Getting this device information Feb 22 13:11:47 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:47 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:11:48 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:11:48 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:49 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:49 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:50 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:50 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:52 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:52 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:52 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:52 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:53 rivo volumio[3579]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Feb 22 13:11:53 rivo volumio[3579]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Feb 22 13:11:53 rivo volumio[3579]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Feb 22 13:11:53 rivo volumio[3579]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Feb 22 13:11:53 rivo volumio[3579]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Feb 22 13:11:53 rivo volumio[3579]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Feb 22 13:11:53 rivo volumio[3579]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 22 13:11:53 rivo volumio[3579]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 22 13:11:54 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:54 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:55 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:55 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:56 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:56 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:57 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:57 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:58 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:58 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:11:59 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:11:59 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:00 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:00 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:01 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:01 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:12:01 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:12:01 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:12:01 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:12:01 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:12:01 rivo volumio[3579]: info: Listing playlists Feb 22 13:12:02 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:02 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:03 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:03 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:04 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:04 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:06 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:06 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:07 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:07 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:08 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:08 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:08 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:08 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:09 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:09 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:10 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:10 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:10 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:10 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:11 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:11 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:13 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:13 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:12:13 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:12:13 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:12:13 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:12:13 rivo volumio[3579]: info: Listing playlists Feb 22 13:12:13 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:13 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:14 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:14 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:16 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:16 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:12:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:12:17 rivo volumio[3579]: info: Discovery: Getting this device information Feb 22 13:12:17 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:17 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:12:17 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 22 13:12:17 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:18 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:12:18 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:12:18 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:12:18 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:12:18 rivo volumio[3579]: info: Listing playlists Feb 22 13:12:18 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:18 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:19 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:12:19 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:12:19 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:12:19 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:12:19 rivo volumio[3579]: info: Listing playlists Feb 22 13:12:19 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:19 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:20 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:20 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:21 rivo volumio[3579]: verbose: New Socket.io Connection to 192.168.5.108 from 192.168.5.157 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:21 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 13:12:21 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 13:12:21 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:21 rivo volumio[3579]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 13:12:21 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:12:21 rivo volumio[3579]: info: CoreCommandRouter::volumioGetQueue Feb 22 13:12:21 rivo volumio[3579]: info: CoreStateMachine::getQueue Feb 22 13:12:21 rivo volumio[3579]: info: CorePlayQueue::getQueue Feb 22 13:12:21 rivo volumio[3579]: info: Listing playlists Feb 22 13:12:21 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:22 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:23 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:23 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:24 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:24 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:25 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Feb 22 13:12:25 rivo volumio[3579]: info: Pausing Remote Device: http://192.168.5.108 Feb 22 13:12:25 rivo volumio[3579]: info: Feb 22 13:12:25 rivo volumio[3579]: ---------------------------- Client requests Volumio pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::volumioPause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::stPlaybackTimer Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::servicePause Feb 22 13:12:25 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::servicePause Feb 22 13:12:25 rivo volumio[3579]: info: [1740226345769] ControllerQobuz::pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::pause Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand pause Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand pause took 3 milliseconds Feb 22 13:12:25 rivo volumio[3579]: info: Feb 22 13:12:25 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:12:25 rivo volumio[3579]: info: Feb 22 13:12:25 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:12:25 rivo volumio[3579]: info: Feb 22 13:12:25 rivo volumio[3579]: ---------------------------- MPD announces state update: player Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::getState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand status Feb 22 13:12:25 rivo volumio[3579]: info: Done pausing: Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand status took 16 milliseconds Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand status took 14 milliseconds Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand status took 9 milliseconds Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseState Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 13:12:25 rivo volumio[3579]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:12:25 rivo volumio[3579]: verbose: ControllerMpd::parseTrackInfo Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:12:25 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:12:25 rivo volumio[3579]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":52605,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1272 Kbps","isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:12:25 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState stateService pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::stPlaybackTimer Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:12:25 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:12:25 rivo volumio[3579]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":52605,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1272 Kbps","isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:12:25 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState stateService pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::stPlaybackTimer Feb 22 13:12:25 rivo volumio[3579]: info: ControllerMpd::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::servicePushState Feb 22 13:12:25 rivo volumio[3579]: info: CorePlayQueue::getTrack 0 Feb 22 13:12:25 rivo volumio[3579]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":52605,"duration":80,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1272 Kbps","isStreaming":false,"title":"285684854","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/285684854","trackType":"qobuz"} Feb 22 13:12:25 rivo volumio[3579]: verbose: CURRENT POSITION 0 Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState stateService pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::syncState currentStatus pause Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::pushState Feb 22 13:12:25 rivo volumio[3579]: info: CoreCommandRouter::volumioPushState Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output update for this device Feb 22 13:12:25 rivo volumio[3579]: info: MRS: Pushing multiroomSync output Feb 22 13:12:25 rivo volumio[3579]: info: CoreStateMachine::stPlaybackTimer Feb 22 13:12:25 rivo volumio[3579]: info: ------------------------------ 62ms Feb 22 13:12:25 rivo volumio[3579]: info: ------------------------------ 62ms Feb 22 13:12:25 rivo volumio[3579]: info: ------------------------------ 57ms Feb 22 13:12:25 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:12:25 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:12:25 rivo volumio[3579]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 22 13:12:26 rivo volumio[3579]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:12:26 rivo volumio[3579]: info: CoreCommandRouter::volumioGetState Feb 22 13:12:26 rivo volumio[3579]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Feb 22 13:12:26 rivo volumio[3579]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Feb 22 13:12:26 rivo volumio[3579]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 13:12:26 rivo volumio[3579]: TypeError: Cannot read property 'then' of undefined Feb 22 13:12:26 rivo volumio[3579]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Feb 22 13:12:26 rivo volumio[3579]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2274:30) Feb 22 13:12:26 rivo volumio[3579]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1450:26) Feb 22 13:12:26 rivo volumio[3579]: at Socket.emit (events.js:400:28) Feb 22 13:12:26 rivo volumio[3579]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 22 13:12:26 rivo volumio[3579]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Feb 22 13:12:26 rivo volumio[3579]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 13:12:27 rivo sudo[17611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-22 13:11 Feb 22 13:12:27 rivo sudo[17611]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:04:03 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e66dc85ea2c87aca7db72b97d00dff"