-- Logs begin at Thu 2025-07-17 20:24:25 EDT, end at Thu 2025-07-17 22:54:36 EDT. -- Jul 17 22:53:19 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 3 Jul 17 22:53:19 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:19 rivoplus volumio[3290]: info: Prefetching next song Jul 17 22:53:19 rivoplus volumio[3290]: info: Doing Prefetch in UPNP Jul 17 22:53:19 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.6.105:32469/object/767cc54512c3e811c54c/file.dsf" Jul 17 22:53:19 rivoplus volumio[3290]: info: Jul 17 22:53:19 rivoplus volumio[3290]: ---------------------------- MPD announces system playlist update Jul 17 22:53:19 rivoplus volumio[3290]: info: Ignoring MPD Status Update Jul 17 22:53:19 rivoplus volumio[3290]: info: sendMpdCommand add "http://192.168.6.105:32469/object/767cc54512c3e811c54c/file.dsf" took 3 milliseconds Jul 17 22:53:19 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 17 22:53:19 rivoplus volumio[3290]: info: ------------------------------ 3ms Jul 17 22:53:19 rivoplus volumio[3290]: info: sendMpdCommand consume 1 took 2 milliseconds Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreStateMachine::startPlaybackTimer Jul 17 22:53:24 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreStateMachine::pushState Jul 17 22:53:24 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushState Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:53:24 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:24 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output update for this device Jul 17 22:53:24 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetQueue Jul 17 22:53:24 rivoplus volumio[3290]: info: CoreStateMachine::getQueue Jul 17 22:53:24 rivoplus volumio[3290]: info: CorePlayQueue::getQueue Jul 17 22:53:24 rivoplus volumio[3290]: info: Signalling Playback active due to playback status change Jul 17 22:53:24 rivoplus volumio[3290]: info: Updating RAAT Signal Path Jul 17 22:53:25 rivoplus volumio[3290]: info: Jul 17 22:53:25 rivoplus volumio[3290]: ---------------------------- MPD announces system playlist update Jul 17 22:53:25 rivoplus volumio[3290]: info: Ignoring MPD Status Update Jul 17 22:53:25 rivoplus volumio[3290]: info: Jul 17 22:53:25 rivoplus volumio[3290]: ---------------------------- MPD announces state update: player Jul 17 22:53:25 rivoplus volumio[3290]: info: ControllerMpd::getState Jul 17 22:53:25 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:53:25 rivoplus volumio[3290]: info: ------------------------------ 6ms Jul 17 22:53:25 rivoplus volumio[3290]: info: sendMpdCommand status took 4 milliseconds Jul 17 22:53:25 rivoplus volumio[3290]: verbose: ControllerMpd::parseState Jul 17 22:53:25 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 22:53:25 rivoplus volumio[3290]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 22:53:25 rivoplus volumio[3290]: verbose: ControllerMpd::parseTrackInfo Jul 17 22:53:25 rivoplus volumio[3290]: info: ControllerMpd::pushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::servicePushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:25 rivoplus volumio[3290]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"file.dsf","artist":null,"album":null,"uri":"http://192.168.6.105:32469/object/767cc54512c3e811c54c/file.dsf","trackType":"dsf"} Jul 17 22:53:25 rivoplus volumio[3290]: verbose: CURRENT POSITION 4 Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::syncState stateService play Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::syncState currentStatus play Jul 17 22:53:25 rivoplus volumio[3290]: info: Received an update from plugin. extracting info from payload Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::pushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:25 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output update for this device Jul 17 22:53:25 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::pushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushState Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:53:25 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output update for this device Jul 17 22:53:25 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output Jul 17 22:53:25 rivoplus volumio[3290]: info: ------------------------------ 79ms Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::getQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: CoreStateMachine::getQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: CorePlayQueue::getQueue Jul 17 22:53:25 rivoplus volumio[3290]: info: Signalling Playback active due to playback status change Jul 17 22:53:25 rivoplus volumio[3290]: info: Signalling Playback active due to playback status change Jul 17 22:53:25 rivoplus volumio[3290]: info: Updating RAAT Signal Path Jul 17 22:53:25 rivoplus volumio[3290]: info: Updating RAAT Signal Path Jul 17 22:53:36 rivoplus dhcpcd[3278]: wlan0: hardware address 66:e9:31:3d:56:79 claims 192.168.6.108 Jul 17 22:53:36 rivoplus dhcpcd[3278]: wlan0: hardware address 66:e9:31:3d:56:79 claims 192.168.6.108 Jul 17 22:53:40 rivoplus volumio[3290]: error: error Jul 17 22:53:40 rivoplus volumio[3290]: error: error Jul 17 22:53:40 rivoplus volumio[3290]: error: error Jul 17 22:54:00 rivoplus volumio[3290]: verbose: New Socket.io Connection to 192.168.6.108 from 192.168.4.40 UA: Mozilla/5.0 (Linux; Android 16; Pixel Tablet Build/BP2A.250605.031.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:54:00 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:54:00 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 22:54:00 rivoplus volumio[3290]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 17 22:54:00 rivoplus volumio[3290]: info: Received Get System Info Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 22:54:00 rivoplus volumio[3290]: info: Discovery: Getting this device information Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:54:00 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:54:00 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:00 rivoplus volumio[3290]: info: Listing playlists Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetQueue Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreStateMachine::getQueue Jul 17 22:54:00 rivoplus volumio[3290]: info: CorePlayQueue::getQueue Jul 17 22:54:00 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 22:54:07 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::ClearQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::stop Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::stPlaybackTimer Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::updateTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::pushState Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushState Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioGetState Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output update for this device Jul 17 22:54:07 rivoplus volumio[3290]: info: MRS: Pushing multiroomSync output Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::serviceStop Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::serviceStop Jul 17 22:54:07 rivoplus volumio[3290]: info: [1752807247646] ControllerUPNPBrowser::stop Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::clearPlayQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::addQueueItems Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::addQueueItems Jul 17 22:54:07 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@f7c7813e1b586b293111 Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@f7c7813e1b586b293111 Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@304d6e22b1a2c126e512 Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@304d6e22b1a2c126e512 Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@d617c164355f226a5989 Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@d617c164355f226a5989 Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@0c5614755163700a510f Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@0c5614755163700a510f Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@767cc54512c3e811c54c Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@767cc54512c3e811c54c Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::updateTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPlay Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::play index 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::addQueueItems Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::addQueueItems Jul 17 22:54:07 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:07 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@c2d0363a51c302a6f563 Jul 17 22:54:07 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@c2d0363a51c302a6f563 Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::stop Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::play index undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::updateTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrackBlock Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: CoreStateMachine::startPlaybackTimer Jul 17 22:54:07 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:07 rivoplus volumio[3290]: info: [1752807247700] ControllerUPNPBrowser::clearAddPlayTrack Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 22:54:07 rivoplus volumio[3290]: info: Updating RAAT Signal Path Jul 17 22:54:07 rivoplus volumio[3290]: info: Jul 17 22:54:07 rivoplus volumio[3290]: ---------------------------- MPD announces state update: player Jul 17 22:54:07 rivoplus volumio[3290]: info: sendMpdCommand stop took 85 milliseconds Jul 17 22:54:07 rivoplus volumio[3290]: info: ControllerMpd::getState Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:54:07 rivoplus volumio[3290]: info: sendMpdCommand stop took 32 milliseconds Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 22:54:07 rivoplus volumio[3290]: info: Jul 17 22:54:07 rivoplus volumio[3290]: ---------------------------- MPD announces system playlist update Jul 17 22:54:07 rivoplus volumio[3290]: info: Ignoring MPD Status Update Jul 17 22:54:07 rivoplus volumio[3290]: info: sendMpdCommand status took 9 milliseconds Jul 17 22:54:07 rivoplus volumio[3290]: info: sendMpdCommand clear took 9 milliseconds Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::parseState Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.6.105:32469/object/767cc54512c3e811c54c/file.dsf" Jul 17 22:54:07 rivoplus volumio[3290]: error: updateQueue error: null Jul 17 22:54:07 rivoplus volumio[3290]: info: ------------------------------ 22ms Jul 17 22:54:07 rivoplus volumio[3290]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 17 22:54:07 rivoplus volumio[3290]: verbose: ControllerMpd::parseTrackInfo Jul 17 22:54:07 rivoplus volumio[3290]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 22:54:07 rivoplus volumio[3290]: info: ------------------------------ 34ms Jul 17 22:54:07 rivoplus volumio[3290]: info: MCU Signalled Playback Inactive Jul 17 22:54:12 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::ClearQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::stop Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::clearPlayQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::addQueueItems Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::addQueueItems Jul 17 22:54:12 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@f7c7813e1b586b293111 Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@f7c7813e1b586b293111 Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@304d6e22b1a2c126e512 Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@304d6e22b1a2c126e512 Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@d617c164355f226a5989 Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@d617c164355f226a5989 Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@0c5614755163700a510f Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@0c5614755163700a510f Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@767cc54512c3e811c54c Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@767cc54512c3e811c54c Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::updateTrackBlock Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::getTrackBlock Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPlay Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::play index 4 Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::addQueueItems Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::addQueueItems Jul 17 22:54:12 rivoplus volumio[3290]: info: Preload queue cleared Jul 17 22:54:12 rivoplus volumio[3290]: info: Adding Item to queue: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@c2d0363a51c302a6f563 Jul 17 22:54:12 rivoplus volumio[3290]: info: Using cached record of: upnp/http://192.168.6.105:32469/ContentDirectory/dcd3afc1-b8c1-0207-d0b5-cadb1f9743b9/control.xml@c2d0363a51c302a6f563 Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::stop Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPushQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::saveQueue Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::play index undefined Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::updateTrackBlock Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::getTrackBlock Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:12 rivoplus volumio[3290]: info: CoreStateMachine::startPlaybackTimer Jul 17 22:54:12 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:12 rivoplus volumio[3290]: info: [1752807252716] ControllerUPNPBrowser::clearAddPlayTrack Jul 17 22:54:12 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 22:54:19 rivoplus volumio[3290]: info: CoreCommandRouter::volumioPlay Jul 17 22:54:19 rivoplus volumio[3290]: info: CoreStateMachine::play index undefined Jul 17 22:54:19 rivoplus volumio[3290]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 22:54:19 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:19 rivoplus volumio[3290]: info: CoreStateMachine::startPlaybackTimer Jul 17 22:54:19 rivoplus volumio[3290]: info: CorePlayQueue::getTrack 4 Jul 17 22:54:19 rivoplus volumio[3290]: info: [1752807259283] ControllerUPNPBrowser::clearAddPlayTrack Jul 17 22:54:19 rivoplus volumio[3290]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 22:54:30 rivoplus mpd_monitor.sh[2841]: MPD Monitor Service: MPD Appears to be inactive, restarting Jul 17 22:54:30 rivoplus systemd[1]: Stopping Music Player Daemon... Jul 17 22:54:30 rivoplus volumio[3290]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 22:54:35 rivoplus volumio[3290]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 17 22:54:36 rivoplus volumio[3290]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 22:54:36 rivoplus volumio[3290]: TypeError: Cannot read property 'length' of undefined Jul 17 22:54:36 rivoplus volumio[3290]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 17 22:54:36 rivoplus volumio[3290]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 17 22:54:36 rivoplus volumio[3290]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 17 22:54:36 rivoplus volumio[3290]: at Parser.emit (events.js:400:28) Jul 17 22:54:36 rivoplus volumio[3290]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 17 22:54:36 rivoplus volumio[3290]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 17 22:54:36 rivoplus volumio[3290]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 17 22:54:36 rivoplus volumio[3290]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 17 22:54:36 rivoplus volumio[3290]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 17 22:54:36 rivoplus volumio[3290]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 17 22:54:36 rivoplus volumio[3290]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 17 22:54:36 rivoplus volumio[3290]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 17 22:54:36 rivoplus volumio[3290]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 17 22:54:36 rivoplus volumio[3290]: at IncomingMessage.emit (events.js:412:35) Jul 17 22:54:36 rivoplus volumio[3290]: at endReadableNT (internal/streams/readable.js:1333:12) Jul 17 22:54:36 rivoplus volumio[3290]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 17 22:54:36 rivoplus volumio[3290]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 22:54:36 rivoplus sudo[28266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-17 22:53 Jul 17 22:54:36 rivoplus sudo[28266]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:55:44 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="66719bc94798fca30ca68a8e6d955a83"