-- Logs begin at Thu 2025-12-04 15:39:19 CET, end at Fri 2025-12-05 19:19:41 CET. -- Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::servicePause Dec 05 19:18:08 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::servicePause Dec 05 19:18:08 rivoplus volumio[3113]: info: [1764958688088] ControllerQobuz::pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:18:08 rivoplus volumio[3113]: info: ControllerMpd::pause Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand pause Dec 05 19:18:08 rivoplus volumio[3113]: info: Dec 05 19:18:08 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:08 rivoplus volumio[3113]: info: sendMpdCommand pause took 5 milliseconds Dec 05 19:18:08 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:08 rivoplus volumio[3113]: info: Dec 05 19:18:08 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:08 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:08 rivoplus volumio[3113]: info: sendMpdCommand status took 3 milliseconds Dec 05 19:18:08 rivoplus volumio[3113]: info: sendMpdCommand status took 8 milliseconds Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:08 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 05 19:18:08 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:08 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:08 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:08 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104720,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"778 Kbps","isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:08 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:18:08 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:08 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104720,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"778 Kbps","isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:08 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus pause Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:08 rivoplus volumio[3113]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:18:08 rivoplus volumio[3113]: info: ------------------------------ 34ms Dec 05 19:18:08 rivoplus volumio[3113]: info: ------------------------------ 33ms Dec 05 19:18:08 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:08 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:08 rivoplus volumio[3113]: info: MCU Signalled Playback Inactive Dec 05 19:18:38 rivoplus volumio[3113]: info: Clearing queue after UPNP request Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::ClearQueue Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::updateTrackBlock Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrackBlock Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::serviceStop Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::serviceStop Dec 05 19:18:38 rivoplus volumio[3113]: info: [1764958718537] ControllerQobuz::stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:18:38 rivoplus volumio[3113]: info: ControllerMpd::stop Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::clearPlayQueue Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::saveQueue Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushQueue Dec 05 19:18:38 rivoplus volumio[3113]: error: Upnp client error: Error: This socket has been ended by the other party Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Dec 05 19:18:38 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:38 rivoplus volumio[3113]: info: sendMpdCommand stop took 59 milliseconds Dec 05 19:18:38 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:38 rivoplus volumio[3113]: info: sendMpdCommand status took 1 milliseconds Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:38 rivoplus volumio[3113]: info: Dec 05 19:18:38 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:38 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:38 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 05 19:18:38 rivoplus volumio[3113]: info: sendMpdCommand status took 1 milliseconds Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:38 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: 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":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:38 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: No code Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: ------------------------------ 28ms Dec 05 19:18:38 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 05 19:18:38 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:38 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:38 rivoplus volumio[3113]: 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":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:38 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus stop Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: No code Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:38 rivoplus volumio[3113]: info: ------------------------------ 45ms Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:38 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:40 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:18:40 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:18:40 rivoplus volumio[3113]: info: Consume mode Dec 05 19:18:40 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:40 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 4ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 2ms Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 4ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 4ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 2ms Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 8ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:40 rivoplus volumio[3113]: info: Dec 05 19:18:40 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:40 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:40 rivoplus volumio[3113]: info: ------------------------------ 2ms Dec 05 19:18:40 rivoplus volumio[3113]: STREAMING PROXY: Handling url /?data=qobuz://song/2794060 Dec 05 19:18:40 rivoplus volumio[3113]: info: Executing endpoint getStreamUrlqobuz Dec 05 19:18:40 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Dec 05 19:18:41 rivoplus volumio[3113]: info: getStreamUrl took 227 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2617098&eid=2794060&fmt=6&profile=raw&app_id=539451548&cid=3121722&etsp=1764962320&hmac=8St2NY8BYSnpq1GbQ8Wo7wsBfIA Dec 05 19:18:41 rivoplus volumio[3113]: STREAMING PROXY: Response: 200, length: 95785956 Dec 05 19:18:41 rivoplus volumio[3113]: info: Dec 05 19:18:41 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:41 rivoplus volumio[3113]: info: Dec 05 19:18:41 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand status took 15 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:41 rivoplus volumio[3113]: info: Dec 05 19:18:41 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand status took 18 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: In UPNP mode Dec 05 19:18:41 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:41 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus stop Dec 05 19:18:41 rivoplus volumio[3113]: info: ------------------------------ 36ms Dec 05 19:18:41 rivoplus volumio[3113]: info: Dec 05 19:18:41 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand status took 14 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: In UPNP mode Dec 05 19:18:41 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:41 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play Dec 05 19:18:41 rivoplus volumio[3113]: info: Received an update from plugin. extracting info from payload Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: ------------------------------ 61ms Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand status took 29 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: In UPNP mode Dec 05 19:18:41 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":1,"seek":846,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"404 Kbps","isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:41 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play Dec 05 19:18:41 rivoplus volumio[3113]: info: Received an update from plugin. extracting info from payload Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: ------------------------------ 73ms Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 52 milliseconds Dec 05 19:18:41 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:41 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:41 rivoplus volumio[3113]: verbose: In UPNP mode Dec 05 19:18:41 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":1,"seek":846,"duration":948,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"404 Kbps","isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:41 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play Dec 05 19:18:41 rivoplus volumio[3113]: info: Received an update from plugin. extracting info from payload Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: ------------------------------ 103ms Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:41 rivoplus volumio[3113]: info: MCU Signalled Playback Active Dec 05 19:18:41 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:18:41 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:18:41 rivoplus volumio[3113]: info: Consume mode Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:41 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 9ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 8ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 5ms Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 4ms Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 5ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 5ms Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 4ms Dec 05 19:18:42 rivoplus volumio[3113]: info: Dec 05 19:18:42 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:42 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:42 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:44 rivoplus volumio[3113]: STREAMING PROXY: Client dropped request, destroying Dec 05 19:18:50 rivoplus volumio[3113]: info: Dec 05 19:18:50 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:50 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:50 rivoplus volumio[3113]: info: Dec 05 19:18:50 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player Dec 05 19:18:50 rivoplus volumio[3113]: info: ControllerMpd::getState Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Dec 05 19:18:50 rivoplus volumio[3113]: info: sendMpdCommand status took 3 milliseconds Dec 05 19:18:50 rivoplus volumio[3113]: info: sendMpdCommand status took 3 milliseconds Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::parseState Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 19:18:50 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 05 19:18:50 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:50 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo Dec 05 19:18:50 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:50 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:50 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService stop Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:18:50 rivoplus volumio[3113]: info: ControllerMpd::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:50 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2794060","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2794060","trackType":"qobuz"} Dec 05 19:18:50 rivoplus volumio[3113]: verbose: CURRENT POSITION 0 Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService stop Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus stop Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: No code Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreStateMachine::pushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:50 rivoplus volumio[3113]: info: ------------------------------ 39ms Dec 05 19:18:50 rivoplus volumio[3113]: info: ------------------------------ 37ms Dec 05 19:18:50 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change Dec 05 19:18:50 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:50 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:50 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:50 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:50 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:51 rivoplus volumio[3113]: info: MCU Signalled Playback Inactive Dec 05 19:18:54 rivoplus volumio[3113]: info: Dec 05 19:18:54 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:54 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:54 rivoplus volumio[3113]: info: Dec 05 19:18:54 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:54 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:54 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:54 rivoplus volumio[3113]: info: ------------------------------ 7ms Dec 05 19:18:54 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:18:54 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:18:54 rivoplus volumio[3113]: info: Consume mode Dec 05 19:18:54 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:54 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:18:55 rivoplus volumio[3113]: info: Clearing queue after UPNP request Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreStateMachine::ClearQueue Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreStateMachine::stop Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 19:18:55 rivoplus volumio[3113]: info: CorePlayQueue::clearPlayQueue Dec 05 19:18:55 rivoplus volumio[3113]: info: CorePlayQueue::saveQueue Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:55 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:55 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushQueue Dec 05 19:18:55 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:18:55 rivoplus volumio[3113]: info: Dec 05 19:18:55 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:55 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:55 rivoplus volumio[3113]: info: Dec 05 19:18:55 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:18:55 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:18:55 rivoplus volumio[3113]: error: updateQueue error: null Dec 05 19:18:55 rivoplus volumio[3113]: error: updateQueue error: null Dec 05 19:18:55 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:18:55 rivoplus volumio[3113]: info: ------------------------------ 2ms Dec 05 19:18:55 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:18:55 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:18:55 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:18:55 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:19:04 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:19:04 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:19:04 rivoplus volumio[3113]: info: Consume mode Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:19:04 rivoplus volumio[3113]: info: Clearing queue after UPNP request Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreStateMachine::ClearQueue Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreStateMachine::stop Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 05 19:19:04 rivoplus volumio[3113]: info: CorePlayQueue::clearPlayQueue Dec 05 19:19:04 rivoplus volumio[3113]: info: CorePlayQueue::saveQueue Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:04 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:04 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushQueue Dec 05 19:19:04 rivoplus volumio[3113]: info: Updating RAAT Signal Path Dec 05 19:19:04 rivoplus volumio[3113]: info: Dec 05 19:19:04 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:19:04 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:19:04 rivoplus volumio[3113]: info: Dec 05 19:19:04 rivoplus volumio[3113]: ---------------------------- MPD announces system playlist update Dec 05 19:19:04 rivoplus volumio[3113]: info: Ignoring MPD Status Update Dec 05 19:19:04 rivoplus volumio[3113]: error: updateQueue error: null Dec 05 19:19:04 rivoplus volumio[3113]: error: updateQueue error: null Dec 05 19:19:04 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:19:04 rivoplus volumio[3113]: info: ------------------------------ 3ms Dec 05 19:19:04 rivoplus volumio[3113]: info: Starting UPNP Playback Dec 05 19:19:04 rivoplus volumio[3113]: info: Preparing playback through UPNP Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:04 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 0 Dec 05 19:19:04 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 05 19:19:12 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82:3000 from 192.168.178.48 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:12 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:12 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:12 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 05 19:19:13 rivoplus sudo[10630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 05 19:19:13 rivoplus sudo[10630]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus sudo[10630]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus sudo[10638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 05 19:19:13 rivoplus sudo[10638]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus sudo[10638]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: Error getting the SSID Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus sudo[10643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 05 19:19:13 rivoplus sudo[10643]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: Error getting the SSID Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus sudo[10643]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus sudo[10649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 05 19:19:13 rivoplus sudo[10649]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: Error getting the SSID Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus kernel: dhd_ioctl_entry: Interface is down Dec 05 19:19:13 rivoplus sudo[10649]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus sudo[10657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 05 19:19:13 rivoplus sudo[10657]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus sudo[10657]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus sudo[10660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:13 rivoplus sudo[10660]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:13 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:13 rivoplus sudo[10660]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:13 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82:3000 from 192.168.178.48 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:13 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:13 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:13 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82:3000 from 192.168.178.48 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 05 19:19:13 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 05 19:19:14 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 05 19:19:14 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 05 19:19:14 rivoplus sudo[10682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 05 19:19:14 rivoplus sudo[10682]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:14 rivoplus sudo[10682]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:14 rivoplus sudo[10686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 05 19:19:14 rivoplus sudo[10686]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:14 rivoplus sudo[10686]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:14 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82 from 192.168.178.48 UA: Mozilla/5.0 (Linux; Android 12; XQ-AS52 Build/58.2.A.10.126; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 05 19:19:15 rivoplus sudo[10690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 05 19:19:15 rivoplus sudo[10690]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:15 rivoplus sudo[10690]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:15 rivoplus sudo[10692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 05 19:19:15 rivoplus sudo[10692]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:15 rivoplus sudo[10692]: pam_unix(sudo:session): session closed for user root Dec 05 19:19:15 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82 from 192.168.178.48 UA: Mozilla/5.0 (Linux; Android 12; XQ-AS52 Build/58.2.A.10.126; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetVisibleSources Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 05 19:19:15 rivoplus volumio[3113]: info: Received Get System Info Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:15 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:15 rivoplus volumio[3113]: info: Listing playlists Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 05 19:19:15 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 05 19:19:16 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 19:19:17 rivoplus volumio[3113]: info: Received Get System Info Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:17 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: Retrieving Cloud Streaming UI Dec 05 19:19:17 rivoplus volumio[3113]: info: Getting Tidal Cloud Configuration Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: Getting Qobuz Cloud Configuration Dec 05 19:19:17 rivoplus volumio[3113]: info: Asking plugin for UI Config Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: Getting Spotify Cloud Configuration Dec 05 19:19:17 rivoplus volumio[3113]: info: Asking plugin for UI Config Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: Saving Spotify Acccount Dec 05 19:19:17 rivoplus volumio[3113]: info: Got it Dec 05 19:19:17 rivoplus volumio[3113]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 05 19:19:17 rivoplus volumio[3113]: info: Got Tidal Cloud Configuration Dec 05 19:19:17 rivoplus volumio[3113]: info: Got it Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 19:19:17 rivoplus volumio[3113]: info: Received Get System Info Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:17 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetBrowseSources Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetBrowseSources Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetBrowseSources Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:17 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 05 19:19:21 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:25 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 05 19:19:25 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:29 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:30 rivoplus volumio[3113]: info: Disabling MyMusic plugin upnp Dec 05 19:19:30 rivoplus sudo[10762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Dec 05 19:19:30 rivoplus sudo[10762]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 05 19:19:30 rivoplus volumio[3113]: error: Upnp client error: Error: This socket has been ended by the other party Dec 05 19:19:30 rivoplus systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:33 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:33 rivoplus volumio[3113]: verbose: New Socket.io Connection to 192.168.178.82:3000 from 192.168.178.48 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 05 19:19:33 rivoplus volumio[3113]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 05 19:19:33 rivoplus volumio[3113]: info: Received Get System Version Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 05 19:19:33 rivoplus volumio[3113]: info: Received Get System Info Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 19:19:33 rivoplus volumio[3113]: info: Discovery: Getting this device information Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::volumioGetState Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 19:19:33 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:37 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 05 19:19:40 rivoplus volumio[3113]: info: Enabling MyMusic plugin upnp Dec 05 19:19:40 rivoplus volumio[3113]: info: Enabling plugin upnp Dec 05 19:19:40 rivoplus volumio[3113]: info: Loading plugin "upnp"... Dec 05 19:19:40 rivoplus volumio[3113]: info: [1764958780717] Starting Upmpd Daemon Dec 05 19:19:40 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 05 19:19:40 rivoplus volumio[3113]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 19:19:40 rivoplus volumio[3113]: Error: listen EADDRINUSE: address already in use :::6599 Dec 05 19:19:40 rivoplus volumio[3113]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Dec 05 19:19:40 rivoplus volumio[3113]: at listenInCluster (net.js:1379:12) Dec 05 19:19:40 rivoplus volumio[3113]: at Server.listen (net.js:1465:7) Dec 05 19:19:40 rivoplus volumio[3113]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Dec 05 19:19:40 rivoplus volumio[3113]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Dec 05 19:19:40 rivoplus volumio[3113]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Dec 05 19:19:40 rivoplus volumio[3113]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 05 19:19:40 rivoplus volumio[3113]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Dec 05 19:19:40 rivoplus volumio[3113]: code: 'EADDRINUSE', Dec 05 19:19:40 rivoplus volumio[3113]: errno: -98, Dec 05 19:19:40 rivoplus volumio[3113]: syscall: 'listen', Dec 05 19:19:40 rivoplus volumio[3113]: address: '::', Dec 05 19:19:40 rivoplus volumio[3113]: port: 6599 Dec 05 19:19:40 rivoplus volumio[3113]: } Dec 05 19:19:40 rivoplus volumio[3113]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 19:19:41 rivoplus sudo[10816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-05 19:18 Dec 05 19:19:41 rivoplus sudo[10816]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:44:55 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="af8df74278231e4f9fb9f04db56c320f"