-- Logs begin at Tue 2025-05-13 18:04:38 CEST, end at Tue 2025-06-03 13:42:12 CEST. -- Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPlay Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::play index 0 Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::stop Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::play index undefined Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:00 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:00 rivoplus volumio[3203]: info: CoreStateMachine::startPlaybackTimer Jun 03 13:41:00 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:00 rivoplus volumio[3203]: info: [1748950860183] ControllerUPNPBrowser::clearAddPlayTrack Jun 03 13:41:00 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 13:41:00 rivoplus volumio[3203]: info: sendMpdCommand stop took 6 milliseconds Jun 03 13:41:00 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand clear Jun 03 13:41:00 rivoplus volumio[3203]: info: Jun 03 13:41:00 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:00 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:00 rivoplus volumio[3203]: info: sendMpdCommand clear took 4 milliseconds Jun 03 13:41:00 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" Jun 03 13:41:00 rivoplus volumio[3203]: info: Jun 03 13:41:00 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:00 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:00 rivoplus volumio[3203]: info: Jun 03 13:41:00 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:00 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:00 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:00 rivoplus volumio[3203]: info: ------------------------------ 14ms Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPlay Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::play index 0 Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::stop Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::play index undefined Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 13:41:01 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:01 rivoplus volumio[3203]: info: CoreStateMachine::startPlaybackTimer Jun 03 13:41:01 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:01 rivoplus volumio[3203]: info: [1748950861670] ControllerUPNPBrowser::clearAddPlayTrack Jun 03 13:41:01 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 13:41:03 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:03 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:03 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" Jun 03 13:41:03 rivoplus volumio[3203]: info: ------------------------------ 3083ms Jun 03 13:41:03 rivoplus volumio[3203]: info: ------------------------------ 3080ms Jun 03 13:41:03 rivoplus volumio[3203]: info: sendMpdCommand stop took 1613 milliseconds Jun 03 13:41:03 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand clear Jun 03 13:41:03 rivoplus volumio[3203]: Upnp client error: Error: This socket has been ended by the other party Jun 03 13:41:03 rivoplus volumio[3203]: info: Jun 03 13:41:03 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:03 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:03 rivoplus volumio[3203]: info: Jun 03 13:41:03 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:03 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:03 rivoplus volumio[3203]: info: sendMpdCommand add "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" took 7 milliseconds Jun 03 13:41:03 rivoplus volumio[3203]: info: sendMpdCommand clear took 5 milliseconds Jun 03 13:41:03 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 13:41:03 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand play Jun 03 13:41:03 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" Jun 03 13:41:03 rivoplus volumio[3203]: info: Jun 03 13:41:03 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:03 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:03 rivoplus volumio[3203]: info: Jun 03 13:41:03 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:03 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:03 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:03 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:03 rivoplus volumio[3203]: info: ------------------------------ 13ms Jun 03 13:41:03 rivoplus volumio[3203]: info: ------------------------------ 13ms Jun 03 13:41:03 rivoplus volumio[3203]: info: sendMpdCommand play took 10 milliseconds Jun 03 13:41:06 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:06 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:06 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 3052ms Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 3051ms Jun 03 13:41:06 rivoplus volumio[3203]: Upnp client error: Error: This socket has been ended by the other party Jun 03 13:41:06 rivoplus volumio[3203]: info: Jun 03 13:41:06 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:06 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:06 rivoplus volumio[3203]: info: Jun 03 13:41:06 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:06 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:06 rivoplus volumio[3203]: info: Jun 03 13:41:06 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:06 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:06 rivoplus volumio[3203]: info: sendMpdCommand add "http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav" took 10 milliseconds Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 7ms Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 5ms Jun 03 13:41:06 rivoplus volumio[3203]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 13:41:06 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand play Jun 03 13:41:06 rivoplus volumio[3203]: info: Jun 03 13:41:06 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:06 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:06 rivoplus volumio[3203]: info: Jun 03 13:41:06 rivoplus volumio[3203]: ---------------------------- MPD announces system playlist update Jun 03 13:41:06 rivoplus volumio[3203]: info: Ignoring MPD Status Update Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 10ms Jun 03 13:41:06 rivoplus volumio[3203]: info: sendMpdCommand play took 8 milliseconds Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 5ms Jun 03 13:41:06 rivoplus volumio[3203]: info: ------------------------------ 4ms Jun 03 13:41:06 rivoplus volumio[3203]: info: MRS: Found cast device: H600-4277405fd19cfa840376409b06c9b425 Jun 03 13:41:09 rivoplus volumio[3203]: info: Jun 03 13:41:09 rivoplus volumio[3203]: ---------------------------- MPD announces state update: player Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::getState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand status Jun 03 13:41:09 rivoplus volumio[3203]: info: Jun 03 13:41:09 rivoplus volumio[3203]: ---------------------------- MPD announces state update: player Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::getState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand status Jun 03 13:41:09 rivoplus volumio[3203]: info: Jun 03 13:41:09 rivoplus volumio[3203]: ---------------------------- MPD announces state update: player Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::getState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand status Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand status took 17 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand status took 19 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand status took 19 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseState Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand clearerror took 22 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand clearerror took 20 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand clearerror took 18 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseTrackInfo Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseTrackInfo Jun 03 13:41:09 rivoplus volumio[3203]: verbose: ControllerMpd::parseTrackInfo Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::servicePushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:09 rivoplus volumio[3203]: 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":"$!transcode-24,.wav","artist":null,"album":null,"uri":"http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav","trackType":"wav"} Jun 03 13:41:09 rivoplus volumio[3203]: verbose: CURRENT POSITION 0 Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState stateService stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState currentStatus stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: No code Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::servicePushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:09 rivoplus volumio[3203]: 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":"$!transcode-24,.wav","artist":null,"album":null,"uri":"http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav","trackType":"wav"} Jun 03 13:41:09 rivoplus volumio[3203]: verbose: CURRENT POSITION 0 Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState stateService stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState currentStatus stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: No code Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: ControllerMpd::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::servicePushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:09 rivoplus volumio[3203]: 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":"$!transcode-24,.wav","artist":null,"album":null,"uri":"http://192.168.1.23:9790/minimserver/*/MUSICA/ALBUM*20DIMOSTRATIVI/BURMESTER*203*20CD/Burmester*20-*201999*20-*20Vorfuhrungs*20CD*20III*20-*20glpcd-115/Burmester*20CD*20III*20-*2001*20-*20A*20Time*20For*20Love.flac/$!transcode-24,.wav","trackType":"wav"} Jun 03 13:41:09 rivoplus volumio[3203]: verbose: CURRENT POSITION 0 Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState stateService stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::syncState currentStatus stop Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: No code Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:09 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:09 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:09 rivoplus volumio[3203]: info: ------------------------------ 217ms Jun 03 13:41:09 rivoplus volumio[3203]: info: ------------------------------ 217ms Jun 03 13:41:09 rivoplus volumio[3203]: info: ------------------------------ 216ms Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:09 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 13:41:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 13:41:10 rivoplus volumio[3203]: info: Discovery: Getting this device information Jun 03 13:41:10 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 13:41:10 rivoplus kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=0x08 Jun 03 13:41:10 rivoplus kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : 0x2 [current] Jun 03 13:41:10 rivoplus kernel: sd 0:0:0:0: [sda] tag#0 ASC=0x4 ASCQ=0x1 Jun 03 13:41:10 rivoplus kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 08 00 Jun 03 13:41:10 rivoplus kernel: blk_update_request: I/O error, dev sda, sector 0 Jun 03 13:41:10 rivoplus kernel: Buffer I/O error on dev sda, logical block 0, async page read Jun 03 13:41:10 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:11 rivoplus volumio[3203]: info: Executing endpoint metavolumio Jun 03 13:41:11 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 13:41:12 rivoplus volumio[3203]: info: Executing endpoint metavolumio Jun 03 13:41:12 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:13 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:13 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 13:41:13 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:13 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 03 13:41:13 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jun 03 13:41:14 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:14 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:16 rivoplus volumio[3203]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 03 13:41:16 rivoplus volumio[3203]: info: Preparing to save Alsa Options, stopping services first Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:16 rivoplus volumio[3203]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"S/PDIF + AES/EBU + I2S"}} Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 13:41:16 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:16 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:16 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:16 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 13:41:16 rivoplus volumio[3203]: info: Found match in Cards Database for ignoring default Mixer Jun 03 13:41:16 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:16 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:16 rivoplus volumio[3203]: info: Setting mixer PCM for card S/PDIF + AES/EBU + I2S Jun 03 13:41:16 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:16 rivoplus volumio[3203]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 03 13:41:16 rivoplus vtcs[3959]: [2025-06-03 13:41:16.874] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jun 03 13:41:16 rivoplus vtcs[3959]: [2025-06-03 13:41:16.886] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jun 03 13:41:16 rivoplus vtcs[3959]: [2025-06-03 13:41:16.886] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jun 03 13:41:16 rivoplus volumio[3203]: info: Ignoring Mixers Options Jun 03 13:41:16 rivoplus volumio[3203]: info: Device 1 does not have any Mixer Control Available Jun 03 13:41:16 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:16 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:16 rivoplus volumio[3203]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 03 13:41:16 rivoplus sudo[5311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:16 rivoplus sudo[5311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:16 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 03 13:41:16 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:16 rivoplus sudo[5314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:16 rivoplus sudo[5314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:16 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 03 13:41:16 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 03 13:41:16 rivoplus sudo[5311]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus sudo[5314]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:17 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 03 13:41:17 rivoplus volumio[3203]: info: Updating Volume Controller Parameters: Device: 1 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 03 13:41:17 rivoplus volumio[3203]: info: Disabling external Volume Control Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:17 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:17 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:17 rivoplus volumio[3203]: info: Preparing to generate the ALSA configuration file Jun 03 13:41:17 rivoplus sudo[5323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:17 rivoplus sudo[5323]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus sudo[5326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:17 rivoplus sudo[5326]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus sudo[5323]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus sudo[5326]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus sudo[5333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 03 13:41:17 rivoplus sudo[5333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus sudo[5333]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:17 rivoplus sudo[5340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 03 13:41:17 rivoplus sudo[5341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 03 13:41:17 rivoplus sudo[5340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus sudo[5341]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus volumio[3203]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 03 13:41:17 rivoplus volumio[3203]: info: Reading ALSA contributions from plugins. Jun 03 13:41:17 rivoplus qobuz-connect[3824]: 20250603 13:41:17.339 [3824.3824] INFO SampleApp: Stopping Local configuration server Jun 03 13:41:17 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 03 13:41:17 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:17 rivoplus sudo[5341]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus qobuz-connect[3824]: 20250603 13:41:17.349 [3824.3824] INFO SampleApp: shat down connection on UNIX socket Jun 03 13:41:17 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 03 13:41:17 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 03 13:41:17 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:17 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 03 13:41:17 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 03 13:41:17 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:17 rivoplus sudo[5340]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:17 rivoplus sudo[5344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 03 13:41:17 rivoplus sudo[5344]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 03 13:41:17 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Jun 03 13:41:17 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 03 13:41:17 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 03 13:41:17 rivoplus sudo[5344]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: Not Reporting Auto name since its the default one Jun 03 13:41:17 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:17 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:17 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:17 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 13:41:17 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:17 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: Not Reporting Auto name since its the default one Jun 03 13:41:17 rivoplus volumio[3203]: info: Executing endpoint qc_getconfig Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.716 [5351.5351] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.723 [5351.5351] INFO VolumeManager: [0xabd898f0]: Setting new playback volume: 75 Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.723 [5351.5351] INFO VolumeManager: [0xabd898f0]: Setting new mute state: 0 Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.723 [5351.5351] INFO QobuzConnect: [0xabd8a2c0]: Client initialized! Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.723 [5351.5351] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.736 [5351.5351] INFO LocalConfigManager: [0xabd891d0]: Starting Local Configuration server Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.736 [5351.5351] INFO SampleApp: Starting Local configuration server Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.737 [5351.5351] INFO SampleApp: Connected to UNIX socket client 0xabd7eed8 Jun 03 13:41:17 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:17 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:17 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 03 13:41:17 rivoplus volumio[3203]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 03 13:41:17 rivoplus sudo[5372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 03 13:41:17 rivoplus sudo[5372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 03 13:41:17 rivoplus sudo[5372]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus qobuz-connect[5351]: 20250603 13:41:17.867 [5351.5351] INFO SampleApp: Playback volume changed: 75 Jun 03 13:41:17 rivoplus sudo[5375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 03 13:41:17 rivoplus sudo[5375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:17 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:17 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 03 13:41:17 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:17 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 03 13:41:17 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 03 13:41:17 rivoplus systemd[1]: Started RAAT DAEMON. Jun 03 13:41:17 rivoplus sudo[5375]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:17 rivoplus volumio[3203]: info: Asound.conf file unchanged, so no further update is needed Jun 03 13:41:17 rivoplus volumio[3203]: info: Output device has changed, restarting MPD Jun 03 13:41:17 rivoplus sudo[5380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 03 13:41:17 rivoplus sudo[5380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:17 rivoplus sudo[5380]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus sudo[5387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 13:41:18 rivoplus sudo[5387]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus sudo[5389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 03 13:41:18 rivoplus sudo[5387]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus sudo[5389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus volumio[3203]: info: Output device has changed, restarting Shairport Sync Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:18 rivoplus sudo[5393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 13:41:18 rivoplus sudo[5393]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus systemd[1]: Stopping Music Player Daemon... Jun 03 13:41:18 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:18 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:18 rivoplus volumio[3203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 13:41:18 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:18 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:18 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 03 13:41:18 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:18 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 03 13:41:18 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 03 13:41:18 rivoplus volumio[3203]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus systemd[1]: Started RAAT DAEMON. Jun 03 13:41:18 rivoplus sudo[5389]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:18 rivoplus systemd[1]: mpd.service: Succeeded. Jun 03 13:41:18 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 03 13:41:18 rivoplus systemd[1]: Starting Music Player Daemon... Jun 03 13:41:18 rivoplus volumio[3203]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus sudo[5419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:18 rivoplus sudo[5419]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus sudo[5413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:18 rivoplus sudo[5413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus sudo[5419]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:18 rivoplus sudo[5413]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:18 rivoplus sudo[5430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 03 13:41:18 rivoplus sudo[5430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus sudo[5410]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 03 13:41:18 rivoplus sudo[5410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:18 rivoplus sudo[5410]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus sudo[5430]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus sudo[5434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 03 13:41:18 rivoplus sudo[5434]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus volumio[3203]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 03 13:41:18 rivoplus volumio[3203]: info: MPD Permissions set Jun 03 13:41:18 rivoplus volumio[3203]: info: Raat Daemon started successfully Jun 03 13:41:18 rivoplus volumio[3203]: info: Raat Daemon started successfully Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:18 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:18 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:18 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 03 13:41:18 rivoplus qobuz-connect[5351]: 20250603 13:41:18.492 [5351.5351] INFO SampleApp: Stopping Local configuration server Jun 03 13:41:18 rivoplus qobuz-connect[5351]: 20250603 13:41:18.503 [5351.5351] INFO SampleApp: shat down connection on UNIX socket Jun 03 13:41:18 rivoplus volumio[3203]: info: Executing endpoint restartRAATSocket Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 03 13:41:18 rivoplus volumio[3203]: info: Executing endpoint restartRAATSocket Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 03 13:41:18 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 03 13:41:18 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 03 13:41:18 rivoplus sudo[5434]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 03 13:41:18 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:18 rivoplus volumio[3203]: info: Not Reporting Auto name since its the default one Jun 03 13:41:18 rivoplus volumio[3203]: info: Executing endpoint qc_getconfig Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.770 [5438.5438] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 03 13:41:18 rivoplus volumio[3203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.776 [5438.5438] INFO VolumeManager: [0xac7988f0]: Setting new playback volume: 75 Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.777 [5438.5438] INFO VolumeManager: [0xac7988f0]: Setting new mute state: 0 Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.777 [5438.5438] INFO QobuzConnect: [0xac7992c0]: Client initialized! Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.777 [5438.5438] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 03 13:41:18 rivoplus volumio[3203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 03 13:41:18 rivoplus volumio[3203]: info: Starting Shairport Sync Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.791 [5438.5438] INFO LocalConfigManager: [0xac7981d0]: Starting Local Configuration server Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.792 [5438.5438] INFO SampleApp: Starting Local configuration server Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.792 [5438.5438] INFO SampleApp: Connected to UNIX socket client 0xac78ded8 Jun 03 13:41:18 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 03 13:41:18 rivoplus volumio[3203]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 03 13:41:18 rivoplus sudo[5456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 13:41:18 rivoplus sudo[5456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:18 rivoplus volumio[3203]: info: Preparing to generate the ALSA configuration file Jun 03 13:41:18 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 03 13:41:18 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 03 13:41:18 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 03 13:41:18 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:18 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:18 rivoplus sudo[5456]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:18 rivoplus qobuz-connect[5438]: 20250603 13:41:18.919 [5438.5438] INFO SampleApp: Playback volume changed: 75 Jun 03 13:41:18 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:18 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:18 rivoplus volumio[3203]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 03 13:41:18 rivoplus volumio[3203]: info: Reading ALSA contributions from plugins. Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:18 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:19 rivoplus sudo[5464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 03 13:41:19 rivoplus sudo[5464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:19 rivoplus volumio[3203]: info: Shairport-Sync Started Jun 03 13:41:19 rivoplus sudo[5464]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus volumio[3203]: info: Asound.conf file written Jun 03 13:41:19 rivoplus sudo[5466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 03 13:41:19 rivoplus sudo[5466]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 03 13:41:19 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:19 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 03 13:41:19 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 03 13:41:19 rivoplus systemd[1]: Started RAAT DAEMON. Jun 03 13:41:19 rivoplus sudo[5469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 03 13:41:19 rivoplus sudo[5469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus sudo[5466]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus sudo[5469]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:19 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card AMLAUGESOUNDMP1 Jun 03 13:41:19 rivoplus volumio[3203]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Jun 03 13:41:19 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card AMLAUGESOUNDMP1 Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card Device Jun 03 13:41:19 rivoplus volumio[3203]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Jun 03 13:41:19 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card Device Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card USB Jun 03 13:41:19 rivoplus volumio[3203]: Found hardware: "USB-Audio" "USB Mixer" "USB34e0:0006" "" "" Jun 03 13:41:19 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:19 rivoplus volumio[3203]: No state is present for card USB Jun 03 13:41:19 rivoplus volumio[3203]: info: Output device has changed, restarting MPD Jun 03 13:41:19 rivoplus sudo[5484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 13:41:19 rivoplus sudo[5484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus volumio[3203]: info: Output device has changed, restarting Shairport Sync Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:19 rivoplus sudo[5484]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus sudo[5487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 13:41:19 rivoplus sudo[5487]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:19 rivoplus systemd[1]: mpd.service: Succeeded. Jun 03 13:41:19 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 03 13:41:19 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:19 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:19 rivoplus volumio[3203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 13:41:19 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:19 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:19 rivoplus volumio[3203]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 03 13:41:19 rivoplus systemd[1]: Starting Music Player Daemon... Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:19 rivoplus volumio[3203]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus sudo[5497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:19 rivoplus sudo[5497]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus sudo[5497]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus sudo[5501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:19 rivoplus sudo[5501]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus sudo[5493]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 03 13:41:19 rivoplus sudo[5493]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus sudo[5501]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus sudo[5493]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:19 rivoplus sudo[5509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:19 rivoplus sudo[5509]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:19 rivoplus volumio[3203]: info: MPD Permissions set Jun 03 13:41:19 rivoplus volumio[3203]: info: Raat Daemon started successfully Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:19 rivoplus sudo[5509]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:19 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:19 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:19 rivoplus sudo[5513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 03 13:41:19 rivoplus sudo[5513]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus volumio[3203]: info: Executing endpoint restartRAATSocket Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus qobuz-connect[5438]: 20250603 13:41:19.722 [5438.5438] INFO SampleApp: Stopping Local configuration server Jun 03 13:41:19 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 03 13:41:19 rivoplus qobuz-connect[5438]: 20250603 13:41:19.732 [5438.5438] INFO SampleApp: shat down connection on UNIX socket Jun 03 13:41:19 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 03 13:41:19 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 03 13:41:19 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 03 13:41:19 rivoplus sudo[5513]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: Executing endpoint metavolumio Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:19 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:19 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 03 13:41:19 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:19 rivoplus volumio[3203]: info: Executing endpoint qc_getconfig Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.886 [5520.5520] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 03 13:41:19 rivoplus volumio[3203]: info: Starting Shairport Sync Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.892 [5520.5520] INFO VolumeManager: [0xac96b8f0]: Setting new playback volume: 75 Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.892 [5520.5520] INFO VolumeManager: [0xac96b8f0]: Setting new mute state: 0 Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.892 [5520.5520] INFO QobuzConnect: [0xac96c2c0]: Client initialized! Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.893 [5520.5520] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.907 [5520.5520] INFO LocalConfigManager: [0xac96b1d0]: Starting Local Configuration server Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.907 [5520.5520] INFO SampleApp: Starting Local configuration server Jun 03 13:41:19 rivoplus qobuz-connect[5520]: 20250603 13:41:19.908 [5520.5520] INFO SampleApp: Connected to UNIX socket client 0xac960ed8 Jun 03 13:41:19 rivoplus volumio[3203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 03 13:41:19 rivoplus sudo[5526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 13:41:19 rivoplus sudo[5526]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:19 rivoplus volumio[3203]: info: Not Reporting Auto name since its the default one Jun 03 13:41:19 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 03 13:41:19 rivoplus volumio[3203]: info: Preparing to generate the ALSA configuration file Jun 03 13:41:19 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 03 13:41:19 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:20 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 03 13:41:20 rivoplus volumio[3203]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 03 13:41:20 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:20 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:20 rivoplus qobuz-connect[5520]: 20250603 13:41:20.035 [5520.5520] INFO SampleApp: Playback volume changed: 75 Jun 03 13:41:20 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:20 rivoplus sudo[5526]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus volumio[3203]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 03 13:41:20 rivoplus volumio[3203]: info: Reading ALSA contributions from plugins. Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:20 rivoplus volumio[3203]: info: Shairport-Sync Started Jun 03 13:41:20 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:20 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 03 13:41:20 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:20 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:20 rivoplus sudo[5559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 03 13:41:20 rivoplus sudo[5559]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:20 rivoplus sudo[5559]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:20 rivoplus sudo[5562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 03 13:41:20 rivoplus sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 03 13:41:20 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:20 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 03 13:41:20 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 03 13:41:20 rivoplus systemd[1]: Started RAAT DAEMON. Jun 03 13:41:20 rivoplus sudo[5562]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:20 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:20 rivoplus volumio[3203]: info: Raat Daemon started successfully Jun 03 13:41:20 rivoplus volumio[3203]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:20 rivoplus volumio[3203]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:20 rivoplus volumio[3203]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:20 rivoplus volumio[3203]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:20 rivoplus sudo[5591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 03 13:41:20 rivoplus sudo[5591]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus volumio[3203]: info: Executing endpoint restartRAATSocket Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 03 13:41:20 rivoplus volumio[3203]: info: Asound.conf file written Jun 03 13:41:20 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 03 13:41:20 rivoplus sudo[5591]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus sudo[5595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 03 13:41:20 rivoplus sudo[5595]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus sudo[5602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 03 13:41:20 rivoplus sudo[5602]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus sudo[5602]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus sudo[5595]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:20 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card AMLAUGESOUNDMP1 Jun 03 13:41:20 rivoplus volumio[3203]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Jun 03 13:41:20 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card AMLAUGESOUNDMP1 Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card Device Jun 03 13:41:20 rivoplus volumio[3203]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Jun 03 13:41:20 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card Device Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card USB Jun 03 13:41:20 rivoplus volumio[3203]: Found hardware: "USB-Audio" "USB Mixer" "USB34e0:0006" "" "" Jun 03 13:41:20 rivoplus volumio[3203]: Hardware is initialized using a generic method Jun 03 13:41:20 rivoplus volumio[3203]: No state is present for card USB Jun 03 13:41:20 rivoplus volumio[3203]: info: Output device has changed, restarting MPD Jun 03 13:41:20 rivoplus sudo[5608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 13:41:20 rivoplus sudo[5608]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus volumio[3203]: info: Output device has changed, restarting Shairport Sync Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:20 rivoplus sudo[5608]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:20 rivoplus sudo[5611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 13:41:20 rivoplus sudo[5611]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:20 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:20 rivoplus systemd[1]: mpd.service: Succeeded. Jun 03 13:41:20 rivoplus systemd[1]: Stopped Music Player Daemon. Jun 03 13:41:20 rivoplus systemd[1]: Starting Music Player Daemon... Jun 03 13:41:20 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:20 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:20 rivoplus volumio[3203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 13:41:20 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:20 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:20 rivoplus volumio[3203]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:20 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:20 rivoplus volumio[3203]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 03 13:41:20 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus sudo[5622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:21 rivoplus sudo[5622]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus sudo[5624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 03 13:41:21 rivoplus sudo[5624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Jun 03 13:41:21 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:21 rivoplus systemd[1]: vtcs.service: Succeeded. Jun 03 13:41:21 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Jun 03 13:41:21 rivoplus sudo[5617]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 03 13:41:21 rivoplus sudo[5617]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus sudo[5617]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus sudo[5622]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:21 rivoplus sudo[5624]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:21 rivoplus sudo[5632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 03 13:41:21 rivoplus volumio[3203]: info: RAAT: Requesting Headphone Status Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 03 13:41:21 rivoplus sudo[5632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus volumio[3203]: info: RAAT: Requesting Headphone Status Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreStateMachine::getcurrentVolume Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:21 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:21 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:21 rivoplus sudo[5632]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus volumio[3203]: info: MPD Permissions set Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:21 rivoplus sudo[5638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:21 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:21 rivoplus sudo[5638]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:21 rivoplus volumio[3203]: info: Executing endpoint tc_getconfig Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 03 13:41:21 rivoplus qobuz-connect[5520]: 20250603 13:41:21.252 [5520.5520] INFO SampleApp: Stopping Local configuration server Jun 03 13:41:21 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 03 13:41:21 rivoplus volumio[3203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 03 13:41:21 rivoplus volumio[3203]: info: MCU Signalled Headphone Mode Disabled Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 03 13:41:21 rivoplus volumio[3203]: info: Reporting Headphone State: false Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:21 rivoplus volumio[3203]: info: MCU Signalled Headphone Mode Disabled Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 03 13:41:21 rivoplus volumio[3203]: info: Reporting Headphone State: false Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:21 rivoplus qobuz-connect[5520]: 20250603 13:41:21.262 [5520.5520] INFO SampleApp: shat down connection on UNIX socket Jun 03 13:41:21 rivoplus systemd[1]: qobuz-connect.service: Succeeded. Jun 03 13:41:21 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:21 rivoplus systemd[1]: Started Volumio Qobuz Connect Service. Jun 03 13:41:21 rivoplus sudo[5638]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:21 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jun 03 13:41:21 rivoplus volumio[3203]: info: QobuzConnect: setDeactiveState invoked Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:21 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:21 rivoplus volumio[3203]: info: Executing endpoint qc_getconfig Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.522 [5640.5640] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.530 [5640.5640] INFO VolumeManager: [0xab6ee8f0]: Setting new playback volume: 75 Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.530 [5640.5640] INFO VolumeManager: [0xab6ee8f0]: Setting new mute state: 0 Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.530 [5640.5640] INFO QobuzConnect: [0xab6ef2c0]: Client initialized! Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.530 [5640.5640] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.551 [5640.5640] INFO LocalConfigManager: [0xab6ee1d0]: Starting Local Configuration server Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.551 [5640.5640] INFO SampleApp: Starting Local configuration server Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.552 [5640.5640] INFO SampleApp: Connected to UNIX socket client 0xab6e3ed8 Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:21 rivoplus volumio[3203]: info: Not Reporting Auto name since its the default one Jun 03 13:41:21 rivoplus volumio[3203]: info: Starting Shairport Sync Jun 03 13:41:21 rivoplus volumio[3203]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 03 13:41:21 rivoplus volumio[3203]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 03 13:41:21 rivoplus sudo[5658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 13:41:21 rivoplus sudo[5658]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus qobuz-connect[5640]: 20250603 13:41:21.672 [5640.5640] INFO SampleApp: Playback volume changed: 75 Jun 03 13:41:21 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 03 13:41:21 rivoplus systemd[1]: shairport-sync.service: Succeeded. Jun 03 13:41:21 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:21 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 03 13:41:21 rivoplus sudo[5658]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:21 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:21 rivoplus volumio[3203]: info: Shairport-Sync Started Jun 03 13:41:21 rivoplus volumio[3203]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:21 rivoplus volumio[3203]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:21 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 03 13:41:21 rivoplus sudo[5668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 03 13:41:21 rivoplus sudo[5668]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:21 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Jun 03 13:41:21 rivoplus volumio[3203]: No protocol specified Jun 03 13:41:21 rivoplus volumio[3203]: xcb_connection_has_error() returned true Jun 03 13:41:21 rivoplus sudo[5668]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:22 rivoplus volumio[3203]: info: RAAT: Requesting Headphone Status Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 03 13:41:22 rivoplus sudo[5676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 03 13:41:22 rivoplus sudo[5676]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:22 rivoplus volumio[3203]: info: MCU Signalled Headphone Mode Disabled Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 03 13:41:22 rivoplus volumio[3203]: info: Reporting Headphone State: false Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:22 rivoplus sudo[5676]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:22 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:22 rivoplus sudo[5678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 03 13:41:22 rivoplus sudo[5678]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:22 rivoplus systemd[1]: Stopping RAAT DAEMON... Jun 03 13:41:22 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 03 13:41:22 rivoplus systemd[1]: raat-daemon.service: Succeeded. Jun 03 13:41:22 rivoplus systemd[1]: Stopped RAAT DAEMON. Jun 03 13:41:22 rivoplus systemd[1]: Started RAAT DAEMON. Jun 03 13:41:22 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:22 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 03 13:41:22 rivoplus sudo[5678]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:22 rivoplus volumio[3203]: info: Raat Daemon started successfully Jun 03 13:41:22 rivoplus volumio[3203]: info: Executing endpoint restartRAATSocket Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 03 13:41:22 rivoplus volumio[3203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 03 13:41:22 rivoplus volumio[3203]: info: Executing endpoint tc_getconfig Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 03 13:41:22 rivoplus vtcs[5672]: STARTING TidalConnect services, version: 1.4.0.34 Jun 03 13:41:22 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:22 rivoplus vtcs[5672]: STARTED TidalConnect services. Jun 03 13:41:22 rivoplus volumio[3203]: info: Executing endpoint tc_connect Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 03 13:41:22 rivoplus volumio[3203]: info: Connecting to TidalConnect Jun 03 13:41:22 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::servicePushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:22 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:22 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:22 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:22 rivoplus volumio[3203]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::servicePushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreStateMachine::pushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::volumioPushState Jun 03 13:41:22 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:22 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output update for this device Jun 03 13:41:22 rivoplus volumio[3203]: info: MRS: Pushing multiroomSync output Jun 03 13:41:22 rivoplus volumio[3203]: info: CorePlayQueue::getTrack 0 Jun 03 13:41:22 rivoplus volumio[3203]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jun 03 13:41:22 rivoplus volumio[3203]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jun 03 13:41:22 rivoplus volumio[3203]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:22 rivoplus volumio[3203]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:22 rivoplus sudo[5716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 03 13:41:22 rivoplus sudo[5716]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:22 rivoplus sudo[5716]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:23 rivoplus volumio[3203]: info: RAAT: Requesting Headphone Status Jun 03 13:41:23 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 03 13:41:23 rivoplus volumio[3203]: info: MCU Signalled Headphone Mode Disabled Jun 03 13:41:23 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 03 13:41:23 rivoplus volumio[3203]: info: Reporting Headphone State: false Jun 03 13:41:23 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:23 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:23 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:23 rivoplus mpd[5635]: Jun 03 13:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 03 13:41:23 rivoplus systemd[1]: Started Music Player Daemon. Jun 03 13:41:23 rivoplus sudo[5611]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:23 rivoplus sudo[5393]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:23 rivoplus sudo[5487]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:23 rivoplus volumio[3203]: error: MPD error: The expression evaluated to a falsy value: Jun 03 13:41:23 rivoplus volumio[3203]: assert.ok(self.idling) Jun 03 13:41:23 rivoplus volumio[3203]: error: The expression evaluated to a falsy value: Jun 03 13:41:23 rivoplus volumio[3203]: assert.ok(self.idling) Jun 03 13:41:23 rivoplus volumio[3203]: error: MPD error: The expression evaluated to a falsy value: Jun 03 13:41:23 rivoplus volumio[3203]: assert.ok(self.idling) Jun 03 13:41:23 rivoplus volumio[3203]: error: The expression evaluated to a falsy value: Jun 03 13:41:23 rivoplus volumio[3203]: assert.ok(self.idling) Jun 03 13:41:23 rivoplus volumio[3203]: error: updateQueue error: null Jun 03 13:41:23 rivoplus volumio[3203]: info: TidalConnect service started! Jun 03 13:41:23 rivoplus volumio[3203]: info: TidalConnect service started! Jun 03 13:41:24 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:24 rivoplus volumio[3203]: info: TidalConnect service stoped! Jun 03 13:41:24 rivoplus volumio[3203]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:24 rivoplus volumio[3203]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 03 13:41:24 rivoplus sudo[5730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 03 13:41:24 rivoplus sudo[5730]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:24 rivoplus sudo[5730]: pam_unix(sudo:session): session closed for user root Jun 03 13:41:24 rivoplus volumio[3203]: info: Executing endpoint metavolumio Jun 03 13:41:24 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 13:41:25 rivoplus volumio[3203]: info: TidalConnect service started! Jun 03 13:41:25 rivoplus volumio[3203]: info: RAAT: Requesting Headphone Status Jun 03 13:41:25 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 03 13:41:25 rivoplus volumio[3203]: info: MCU Signalled Headphone Mode Disabled Jun 03 13:41:25 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 03 13:41:25 rivoplus volumio[3203]: info: Reporting Headphone State: false Jun 03 13:41:25 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:25 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 13:41:25 rivoplus volumio[3203]: info: Updating RAAT Signal Path Jun 03 13:41:25 rivoplus volumio[3203]: info: TidalConnect service started! Jun 03 13:41:27 rivoplus volumio[3203]: info: TidalConnect service started! Jun 03 13:41:36 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:38 rivoplus volumio[3203]: info: Executing endpoint metavolumio Jun 03 13:41:38 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: Retrieving Cloud Streaming UI Jun 03 13:41:39 rivoplus volumio[3203]: info: Getting Tidal Cloud Configuration Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: Getting Qobuz Cloud Configuration Jun 03 13:41:39 rivoplus volumio[3203]: info: Asking plugin for UI Config Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: Getting Spotify Cloud Configuration Jun 03 13:41:39 rivoplus volumio[3203]: info: Asking plugin for UI Config Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: Saving Spotify Acccount Jun 03 13:41:39 rivoplus volumio[3203]: info: Got it Jun 03 13:41:39 rivoplus volumio[3203]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 03 13:41:39 rivoplus volumio[3203]: info: Got Tidal Cloud Configuration Jun 03 13:41:39 rivoplus volumio[3203]: info: Got it Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetBrowseSources Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetBrowseSources Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetBrowseSources Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:41:39 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 03 13:41:40 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 13:41:40 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 13:41:40 rivoplus volumio[3203]: info: Discovery: Getting this device information Jun 03 13:41:40 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:41:40 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 13:41:43 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:41:47 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:41:51 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:41:55 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:41:57 rivoplus volumio[3203]: info: Disabling MyMusic plugin upnp Jun 03 13:41:57 rivoplus sudo[5793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 03 13:41:57 rivoplus sudo[5793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 13:41:57 rivoplus volumio[3203]: error: Upnp client error: Error: This socket has been ended by the other party Jun 03 13:41:57 rivoplus systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 03 13:41:57 rivoplus volumio[3203]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 03 13:41:59 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:42:03 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:42:07 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:42:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 13:42:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 13:42:10 rivoplus volumio[3203]: info: Discovery: Getting this device information Jun 03 13:42:10 rivoplus volumio[3203]: info: CoreCommandRouter::volumioGetState Jun 03 13:42:10 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 13:42:11 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 03 13:42:12 rivoplus volumio[3203]: info: Enabling MyMusic plugin upnp Jun 03 13:42:12 rivoplus volumio[3203]: info: Enabling plugin upnp Jun 03 13:42:12 rivoplus volumio[3203]: info: Loading plugin "upnp"... Jun 03 13:42:12 rivoplus volumio[3203]: info: [1748950932141] Starting Upmpd Daemon Jun 03 13:42:12 rivoplus volumio[3203]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 13:42:12 rivoplus volumio[3203]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 13:42:12 rivoplus volumio[3203]: Error: listen EADDRINUSE: address already in use :::6599 Jun 03 13:42:12 rivoplus volumio[3203]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jun 03 13:42:12 rivoplus volumio[3203]: at listenInCluster (net.js:1379:12) Jun 03 13:42:12 rivoplus volumio[3203]: at Server.listen (net.js:1465:7) Jun 03 13:42:12 rivoplus volumio[3203]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 03 13:42:12 rivoplus volumio[3203]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 03 13:42:12 rivoplus volumio[3203]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 03 13:42:12 rivoplus volumio[3203]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 03 13:42:12 rivoplus volumio[3203]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jun 03 13:42:12 rivoplus volumio[3203]: code: 'EADDRINUSE', Jun 03 13:42:12 rivoplus volumio[3203]: errno: -98, Jun 03 13:42:12 rivoplus volumio[3203]: syscall: 'listen', Jun 03 13:42:12 rivoplus volumio[3203]: address: '::', Jun 03 13:42:12 rivoplus volumio[3203]: port: 6599 Jun 03 13:42:12 rivoplus volumio[3203]: } Jun 03 13:42:12 rivoplus volumio[3203]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 13:42:12 rivoplus sudo[5879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-03 13:41 Jun 03 13:42:12 rivoplus sudo[5879]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:04:38 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="0064c1a7ac4363e567dacab062cb5da8"