-- Logs begin at Wed 2025-07-02 16:13:11 CEST, end at Sat 2025-07-05 12:09:59 CEST. -- Jul 05 12:08:03 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:06 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:06 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:09 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:09 volumio volumio[659]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::ClearQueue Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:08:09 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::serviceStop Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:09 volumio volumio[659]: info: CoreCommandRouter::serviceStop Jul 05 12:08:09 volumio volumio[659]: info: [1751710089188] ControllerWebradio::stop Jul 05 12:08:09 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::clearPlayQueue Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:08:09 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:08:09 volumio volumio[659]: info: CoreStateMachine::addQueueItems Jul 05 12:08:09 volumio volumio[659]: info: CorePlayQueue::addQueueItems Jul 05 12:08:09 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:09 volumio volumio[659]: info: Adding Item to queue: upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1 Jul 05 12:08:09 volumio volumio[659]: info: Exploding uri upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1 in service upnp_browser Jul 05 12:08:09 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPlay Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::play index 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::play index undefined Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:11 volumio volumio[659]: info: Jul 05 12:08:11 volumio volumio[659]: ---------------------------- MPD announces state update: player Jul 05 12:08:11 volumio volumio[659]: info: sendMpdCommand stop took 2196 milliseconds Jul 05 12:08:11 volumio volumio[659]: info: ControllerMpd::getState Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:08:11 volumio volumio[659]: info: Jul 05 12:08:11 volumio volumio[659]: ---------------------------- MPD announces state update: player Jul 05 12:08:11 volumio volumio[659]: info: ControllerMpd::getState Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:08:11 volumio volumio[659]: info: sendMpdCommand status took 123 milliseconds Jul 05 12:08:11 volumio volumio[659]: info: sendMpdCommand status took 110 milliseconds Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::parseState Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::parseState Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:08:11 volumio volumio[659]: info: sendMpdCommand playlistinfo took 119 milliseconds Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:08:11 volumio volumio[659]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:08:11 volumio volumio[659]: info: ControllerMpd::pushState Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::servicePushState Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: 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":"Bernhard Henrik Crusell","artist":"VRT Klara Continuo","album":null,"uri":"http://icecast.vrtcdn.be/klaracontinuo-high.mp3/tunein","trackType":"mp3/tunein"} Jul 05 12:08:11 volumio volumio[659]: verbose: CURRENT POSITION 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::syncState stateService stop Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:11 volumio volumio[659]: info: No code Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:11 volumio volumio[659]: info: ControllerMpd::pushState Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::servicePushState Jul 05 12:08:11 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:11 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:11 volumio volumio[659]: 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":"Bernhard Henrik Crusell","artist":"VRT Klara Continuo","album":null,"uri":"http://icecast.vrtcdn.be/klaracontinuo-high.mp3/tunein","trackType":"mp3/tunein"} Jul 05 12:08:11 volumio volumio[659]: verbose: CURRENT POSITION 0 Jul 05 12:08:12 volumio volumio[659]: info: CoreStateMachine::syncState stateService stop Jul 05 12:08:12 volumio volumio[659]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:08:12 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:12 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:12 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:12 volumio volumio[659]: info: No code Jul 05 12:08:12 volumio volumio[659]: info: CoreStateMachine::pushState Jul 05 12:08:12 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:12 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Jul 05 12:08:14 volumio volumio[659]: info: ------------------------------ 2771ms Jul 05 12:08:14 volumio volumio[659]: info: ------------------------------ 2767ms Jul 05 12:08:14 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:15 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:08:15 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:08:15 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:08:15 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:08:15 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:15 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:08:16 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:16 volumio volumio[659]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:08:16 volumio volumio[659]: info: CoreStateMachine::ClearQueue Jul 05 12:08:16 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:08:16 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:16 volumio volumio[659]: info: CorePlayQueue::clearPlayQueue Jul 05 12:08:16 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:08:16 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:08:16 volumio volumio[659]: info: CoreStateMachine::addQueueItems Jul 05 12:08:16 volumio volumio[659]: info: CorePlayQueue::addQueueItems Jul 05 12:08:16 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:16 volumio volumio[659]: info: Adding Item to queue: upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 Jul 05 12:08:16 volumio volumio[659]: info: Exploding uri upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 in service upnp_browser Jul 05 12:08:32 volumio volumio-remote-updater[439]: [2025-07-05 10:08:32] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 05 12:08:37 volumio volumio-remote-updater[439]: [2025-07-05 10:08:37] [connect] Successful connection Jul 05 12:08:45 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::ClearQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::clearPlayQueue Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::addQueueItems Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::addQueueItems Jul 05 12:08:45 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:45 volumio volumio[659]: info: Adding Item to queue: upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 Jul 05 12:08:45 volumio volumio[659]: info: Exploding uri upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 in service upnp_browser Jul 05 12:08:45 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::ClearQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::clearPlayQueue Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::addQueueItems Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::addQueueItems Jul 05 12:08:45 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:45 volumio volumio[659]: info: Adding Item to queue: upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 Jul 05 12:08:45 volumio volumio[659]: info: Exploding uri upnp/folder/http://192.168.0.193:8200/ctl/ContentDir@1$4 in service upnp_browser Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::volumioPlay Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::play index undefined Jul 05 12:08:45 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:08:45 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 05 12:08:45 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:46 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:46 volumio volumio[659]: info: Preload queue cleared Jul 05 12:08:46 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217:3000 from 192.168.0.103 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jul 05 12:08:46 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 2 Jul 05 12:08:46 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:08:46 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:08:46 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:08:46 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:08:46 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:08:46 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:47 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:08:50 volumio volumio-remote-updater[439]: [2025-07-05 10:08:50] [connect] Successful connection Jul 05 12:09:02 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:09:02 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Jul 05 12:09:02 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Jul 05 12:09:02 volumio volumio[659]: info: CoreCommandRouter::volumioPlay Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::play index 0 Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::play index undefined Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:02 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:02 volumio volumio[659]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:09:02 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:02 volumio volumio[659]: info: [1751710142950] ControllerUPNPBrowser::clearAddPlayTrack Jul 05 12:09:02 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:09:03 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217:3000 from 192.168.0.103 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Jul 05 12:09:03 volumio volumio[659]: error: error Jul 05 12:09:03 volumio volumio[659]: error: error Jul 05 12:09:03 volumio volumio[659]: error: error Jul 05 12:09:03 volumio volumio[659]: error: error Jul 05 12:09:03 volumio volumio[659]: info: sendMpdCommand stop took 817 milliseconds Jul 05 12:09:03 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:09:03 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:03 volumio volumio[659]: info: Preload queue cleared Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3C5 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$87A Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$389 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7A5 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$53F Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$EC Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3A Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$117 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$56B Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$20 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$47E Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$362 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$77C Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1C2 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$608 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$46A Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$C Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$95D Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2E3 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$71C Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$30F Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$748 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$339 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$76A Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1B0 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5DC Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5EB Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1CF Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$615 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4EF Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7B Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$425 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$835 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$319 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$752 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$40E Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$81E Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4D7 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$63 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4E3 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6F Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6B6 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$507 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$93 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$917 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$211 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$657 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5AA Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$89E Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6D8 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$46 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4B7 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3F6 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7FF Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$939 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2A4 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$96F Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$231 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$677 Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$88B Jul 05 12:09:03 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$577 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$8AE Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$557 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$104 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$79B Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$37F Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$8BE Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1DC Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$622 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$123 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$138 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$156 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$58C Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$261 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6A7 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$40 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4B1 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4AB Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$396 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7B2 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$39E Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7BA Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$31F Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$758 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2F8 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$731 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$180 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$18C Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5B6 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$865 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$251 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$697 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3AA Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7C6 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4C9 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$55 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$981 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$925 Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3BD Jul 05 12:09:04 volumio volumio[659]: info: Preloading song: upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7D9 Jul 05 12:09:05 volumio volumio-remote-updater[439]: [2025-07-05 10:09:05] [connect] Successful connection Jul 05 12:09:18 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:09:18 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Jul 05 12:09:18 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Jul 05 12:09:18 volumio volumio[659]: info: CoreCommandRouter::volumioPlay Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::play index 0 Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::play index undefined Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:18 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:18 volumio volumio[659]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:09:18 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:18 volumio volumio[659]: info: [1751710158686] ControllerUPNPBrowser::clearAddPlayTrack Jul 05 12:09:18 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:09:18 volumio volumio[659]: info: Jul 05 12:09:18 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:18 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:18 volumio volumio[659]: info: sendMpdCommand clear took 14936 milliseconds Jul 05 12:09:18 volumio volumio[659]: info: sendMpdCommand stop took 23 milliseconds Jul 05 12:09:18 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:18 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:09:18 volumio volumio[659]: info: Jul 05 12:09:18 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:18 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:19 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 4 Jul 05 12:09:19 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 5 Jul 05 12:09:19 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 6 Jul 05 12:09:19 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 7 Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3C5 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$87A in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$389 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7A5 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$53F in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$EC in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3A in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$117 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$56B in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$20 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$47E in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$362 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$77C in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1C2 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$608 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$46A in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$C in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$95D in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2E3 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$71C in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$30F in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$748 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$339 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$76A in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1B0 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5DC in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5EB in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1CF in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$615 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4EF in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7B in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$425 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$835 in service upnp_browser Jul 05 12:09:19 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$319 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$752 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$40E in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$81E in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4D7 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$63 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4E3 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$88B in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6F in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6B6 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$507 in service upnp_browser Jul 05 12:09:20 volumio volumio-remote-updater[439]: [2025-07-05 10:09:20] [connect] Successful connection Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$93 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$917 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$211 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$657 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5AA in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$89E in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6D8 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$46 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4B7 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3F6 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7FF in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$939 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2A4 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$96F in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$231 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$677 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$577 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$8AE in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$557 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$104 in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$79B in service upnp_browser Jul 05 12:09:20 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$37F in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$8BE in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$1DC in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$622 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$123 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$138 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$156 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$58C in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$261 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$6A7 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$40 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4B1 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4AB in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$396 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7B2 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$39E in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7BA in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$31F in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$758 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$2F8 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$731 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$180 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$18C in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$5B6 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$865 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$251 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$697 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3AA in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7C6 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$4C9 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$55 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$981 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$925 in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$3BD in service upnp_browser Jul 05 12:09:21 volumio volumio[659]: info: Exploding uri upnp/http://192.168.0.193:8200/ctl/ContentDir@1$4$7D9 in service upnp_browser Jul 05 12:09:22 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:22 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:22 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:22 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:22 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:22 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:22 volumio volumio[659]: error: updateQueue error: null Jul 05 12:09:22 volumio volumio[659]: info: ------------------------------ 3410ms Jul 05 12:09:22 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:22 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:22 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 6 Jul 05 12:09:22 volumio volumio[659]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 05 12:09:22 volumio volumio[659]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jul 05 12:09:22 volumio volumio[659]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 05 12:09:22 volumio volumio[659]: error: error Jul 05 12:09:33 volumio volumio[659]: info: CoreCommandRouter::volumioPushQueue Jul 05 12:09:34 volumio volumio[659]: info: CorePlayQueue::saveQueue Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Jul 05 12:09:34 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Jul 05 12:09:34 volumio volumio[659]: info: CoreCommandRouter::volumioPlay Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::play index 0 Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::stop Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::play index undefined Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:09:34 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:34 volumio volumio[659]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:09:34 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:34 volumio volumio[659]: info: [1751710174082] ControllerUPNPBrowser::clearAddPlayTrack Jul 05 12:09:34 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:09:34 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:34 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:34 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 10 Jul 05 12:09:34 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.151 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 11 Jul 05 12:09:35 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:35 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:35 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:35 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:35 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:35 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:35 volumio volumio-remote-updater[439]: [2025-07-05 10:09:35] [connect] Successful connection Jul 05 12:09:36 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:36 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:36 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:36 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:36 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:36 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:36 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:36 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:36 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:36 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:37 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:09:37 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:37 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:37 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:37 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: Listing playlists Jul 05 12:09:38 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:38 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:38 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:09:38 volumio volumio[659]: info: CoreStateMachine::getQueue Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getQueue Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:09:38 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:38 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: Listing playlists Jul 05 12:09:38 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:38 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:38 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:38 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:38 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreStateMachine::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Listing playlists Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreStateMachine::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Listing playlists Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreStateMachine::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetVisibleSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Listing playlists Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: Received Get System Info Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:09:39 volumio volumio[659]: info: Discovery: Getting this device information Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Jul 05 12:09:39 volumio volumio[659]: info: CoreCommandRouter::volumioGetQueue Jul 05 12:09:39 volumio volumio[659]: info: CoreStateMachine::getQueue Jul 05 12:09:39 volumio volumio[659]: info: CorePlayQueue::getQueue Jul 05 12:09:42 volumio volumio[659]: error: updateQueue error: null Jul 05 12:09:42 volumio volumio[659]: info: Jul 05 12:09:42 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:42 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:42 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:42 volumio volumio[659]: info: sendMpdCommand clear took 23809 milliseconds Jul 05 12:09:42 volumio volumio[659]: info: ------------------------------ 23781ms Jul 05 12:09:42 volumio volumio[659]: info: sendMpdCommand stop took 8443 milliseconds Jul 05 12:09:42 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:42 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:09:42 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:42 volumio volumio[659]: info: Jul 05 12:09:42 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:42 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:42 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:42 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 12:09:43 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 12:09:43 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 05 12:09:43 volumio volumio[659]: verbose: New Socket.io Connection to 192.168.0.217:3000 from 192.168.0.103 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jul 05 12:09:43 volumio volumio[659]: info: Jul 05 12:09:43 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:43 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:43 volumio volumio[659]: error: updateQueue error: null Jul 05 12:09:43 volumio volumio[659]: info: Jul 05 12:09:43 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:43 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:43 volumio volumio[659]: info: sendMpdCommand add "http://192.168.0.193:8200/MediaItems/17597.flac" took 1067 milliseconds Jul 05 12:09:43 volumio volumio[659]: info: ------------------------------ 1076ms Jul 05 12:09:43 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:43 volumio volumio[659]: info: sendMpdCommand clear took 1056 milliseconds Jul 05 12:09:43 volumio volumio[659]: info: ------------------------------ 1021ms Jul 05 12:09:43 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 12:09:43 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:09:43 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:43 volumio volumio[659]: info: Jul 05 12:09:43 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:43 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:49 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:50 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Jul 05 12:09:50 volumio volumio-remote-updater[439]: [2025-07-05 10:09:50] [connect] Successful connection Jul 05 12:09:50 volumio volumio[659]: info: Preload queue cleared Jul 05 12:09:50 volumio volumio[659]: error: updateQueue error: null Jul 05 12:09:50 volumio volumio[659]: info: Jul 05 12:09:50 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:50 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:50 volumio volumio[659]: info: Jul 05 12:09:50 volumio volumio[659]: ---------------------------- MPD announces state update: player Jul 05 12:09:50 volumio volumio[659]: info: ------------------------------ 7221ms Jul 05 12:09:50 volumio volumio[659]: info: sendMpdCommand add "http://192.168.0.193:8200/MediaItems/17597.flac" took 7193 milliseconds Jul 05 12:09:50 volumio volumio[659]: info: ------------------------------ 7208ms Jul 05 12:09:50 volumio volumio[659]: info: sendMpdCommand play took 7187 milliseconds Jul 05 12:09:50 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.193:8200/MediaItems/17597.flac" Jul 05 12:09:50 volumio volumio[659]: info: ------------------------------ 7163ms Jul 05 12:09:50 volumio volumio[659]: info: ControllerMpd::getState Jul 05 12:09:50 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:09:50 volumio volumio[659]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 05 12:09:50 volumio volumio[659]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:09:50 volumio volumio[659]: info: Jul 05 12:09:50 volumio volumio[659]: ---------------------------- MPD announces system playlist update Jul 05 12:09:50 volumio volumio[659]: info: Ignoring MPD Status Update Jul 05 12:09:51 volumio volumio[659]: Upnp client error: Error: This socket has been ended by the other party Jul 05 12:09:51 volumio volumio[659]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:09:51 volumio volumio[659]: TypeError: Cannot read property 'length' of undefined Jul 05 12:09:51 volumio volumio[659]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 05 12:09:51 volumio volumio[659]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 05 12:09:51 volumio volumio[659]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 05 12:09:51 volumio volumio[659]: at Parser.emit (events.js:315:20) Jul 05 12:09:51 volumio volumio[659]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 05 12:09:51 volumio volumio[659]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 05 12:09:51 volumio volumio[659]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 05 12:09:51 volumio volumio[659]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 05 12:09:51 volumio volumio[659]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 05 12:09:51 volumio volumio[659]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 05 12:09:51 volumio volumio[659]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 05 12:09:51 volumio volumio[659]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 05 12:09:51 volumio volumio[659]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 05 12:09:51 volumio volumio[659]: at IncomingMessage.emit (events.js:327:22) Jul 05 12:09:51 volumio volumio[659]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 05 12:09:51 volumio volumio[659]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 05 12:09:51 volumio volumio[659]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:09:59 volumio sudo[10490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 12:08 Jul 05 12:09:59 volumio sudo[10490]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"