-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Wed 2025-04-30 12:41:26 +07. -- Apr 30 12:40:02 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:02 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::volumioPause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::servicePause Apr 30 12:40:04 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::servicePause Apr 30 12:40:04 volumio volumio[926]: info: [1745991604109] ControllerUPNPBrowser::pause Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand pause Apr 30 12:40:04 volumio volumio[926]: info: Apr 30 12:40:04 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand pause took 1 milliseconds Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:04 volumio volumio[926]: info: Apr 30 12:40:04 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:04 volumio volumio[926]: info: Apr 30 12:40:04 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand status took 4 milliseconds Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand status took 3 milliseconds Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand status took 2 milliseconds Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 12:40:04 volumio volumio[926]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:04 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:04 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:04 volumio volumio[926]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":61981,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:04 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState stateService pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:04 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:04 volumio volumio[926]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":61981,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:04 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState stateService pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:40:04 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:04 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:04 volumio volumio[926]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":61981,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:04 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState stateService pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus pause Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:04 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:04 volumio volumio[926]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:40:04 volumio volumio[926]: info: ------------------------------ 57ms Apr 30 12:40:04 volumio volumio[926]: info: ------------------------------ 56ms Apr 30 12:40:04 volumio volumio[926]: info: ------------------------------ 55ms Apr 30 12:40:04 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:04 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:04 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:04 volumio volumio[926]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 30 12:40:07 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:07 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPlay Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::play index undefined Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::startPlaybackTimer Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: [1745991609434] ControllerUPNPBrowser::resume Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand play Apr 30 12:40:09 volumio volumio[926]: info: Apr 30 12:40:09 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand play took 8 milliseconds Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:09 volumio volumio[926]: info: Apr 30 12:40:09 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:09 volumio volumio[926]: info: Apr 30 12:40:09 volumio volumio[926]: ---------------------------- MPD announces state update: player Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::getState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand status Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand status took 5 milliseconds Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand status took 3 milliseconds Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand status took 3 milliseconds Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseState Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 12:40:09 volumio volumio[926]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:09 volumio volumio[926]: verbose: ControllerMpd::parseTrackInfo Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61981,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:09 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus pause Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":62004,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:09 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:40:09 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:09 volumio volumio[926]: info: ControllerMpd::pushState Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::servicePushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: verbose: STATE SERVICE {"status":"play","position":0,"seek":62027,"duration":364,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"434.wav","artist":null,"album":null,"uri":"http://192.168.1.4:8200/MediaItems/434.wav","trackType":"wav"} Apr 30 12:40:09 volumio volumio[926]: verbose: CURRENT POSITION 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState stateService play Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:40:09 volumio volumio[926]: info: Received an update from plugin. extracting info from payload Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::pushState Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getTrack 0 Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioPushState Apr 30 12:40:09 volumio volumio[926]: info: ------------------------------ 111ms Apr 30 12:40:09 volumio volumio[926]: info: ------------------------------ 110ms Apr 30 12:40:09 volumio volumio[926]: info: ------------------------------ 110ms Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:40:09 volumio volumio[926]: info: CoreStateMachine::getQueue Apr 30 12:40:09 volumio volumio[926]: info: CorePlayQueue::getQueue Apr 30 12:40:09 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:09 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:09 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:09 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:09 volumio volumio[926]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 30 12:40:16 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:17 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B7 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E1 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B8 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E2 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B9 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E3 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E4 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E5 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BC Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E6 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BD Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E7 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BE Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E8 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BF Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E9 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EC Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3ED Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EE Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EF Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F4 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E4 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F5 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E5 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C2 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CD Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C9 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$348 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$357 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$186 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1DF Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$18F Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$34 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$377 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D5 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$BF Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36A Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3A8 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17D Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2B Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F6 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FC Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E6 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C3 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CE Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$187 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$349 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$358 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3C0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$378 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1E0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$190 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$35 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D6 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36B Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3A9 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1EA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3F0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$DA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17E Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2C Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F7 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FD Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E7 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$188 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CF Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$34A Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$359 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C4 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$191 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1E1 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$379 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D7 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C1 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3AA Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1EB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3F1 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$DB Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36C Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17F Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2D Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F8 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FE Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E8 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D0 Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CC Apr 30 12:40:17 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$35A Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E0 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B7 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E1 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B8 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E2 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3B9 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BA in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E3 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E4 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BB in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E5 in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BC in service upnp_browser Apr 30 12:40:17 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E6 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BD in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E7 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BE in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E8 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3BF in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3E9 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EA in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EB in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EC in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3ED in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EE in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3EF in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F4 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FA in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E4 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F5 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FB in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E5 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C2 in service upnp_browser Apr 30 12:40:18 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CD in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C9 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$348 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$357 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$186 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1DF in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$18F in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$34 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$377 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D5 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$BF in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36A in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3A8 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17D in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2B in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F6 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FC in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E6 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C3 in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CE in service upnp_browser Apr 30 12:40:19 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CA in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$187 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$349 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$358 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3C0 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$378 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1E0 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$190 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$35 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D6 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C0 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36B in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3A9 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1EA in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3F0 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$DA in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17E in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2C in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$0 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F7 in service upnp_browser Apr 30 12:40:20 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FD in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E7 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$188 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1CF in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CB in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$34A in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$359 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1C4 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$191 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1E1 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$379 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D7 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$C1 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3AA in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1EB in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3F1 in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$DB in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$36C in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$17F in service upnp_browser Apr 30 12:40:21 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$2D in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1 in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1F8 in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$3FE in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$E8 in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$1D0 in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$CC in service upnp_browser Apr 30 12:40:22 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@1$4$35A in service upnp_browser Apr 30 12:40:27 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:27 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:38 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:38 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:41 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:41 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:45 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:45 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:47 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:48 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:57 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:57 volumio volumio[926]: info: Preload queue cleared Apr 30 12:40:58 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:40:58 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:00 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:00 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:02 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:02 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:04 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:04 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:04 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@64$0$1$0 Apr 30 12:41:04 volumio volumio[926]: info: Preloading song: upnp/http://192.168.1.4:8200/ctl/ContentDir@64$0$1$1 Apr 30 12:41:04 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@64$0$1$0 in service upnp_browser Apr 30 12:41:04 volumio volumio[926]: info: Exploding uri upnp/http://192.168.1.4:8200/ctl/ContentDir@64$0$1$1 in service upnp_browser Apr 30 12:41:06 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:06 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:21 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:21 volumio volumio[926]: info: Preload queue cleared Apr 30 12:41:25 volumio volumio[926]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 30 12:41:25 volumio volumio[926]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:41:25 volumio volumio[926]: TypeError: Cannot read property 'length' of undefined Apr 30 12:41:25 volumio volumio[926]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 30 12:41:25 volumio volumio[926]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 30 12:41:25 volumio volumio[926]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 30 12:41:25 volumio volumio[926]: at Parser.emit (events.js:315:20) Apr 30 12:41:25 volumio volumio[926]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 30 12:41:25 volumio volumio[926]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 30 12:41:25 volumio volumio[926]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 30 12:41:25 volumio volumio[926]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 30 12:41:25 volumio volumio[926]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 30 12:41:25 volumio volumio[926]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 30 12:41:25 volumio volumio[926]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 30 12:41:25 volumio volumio[926]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 30 12:41:25 volumio volumio[926]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 30 12:41:25 volumio volumio[926]: at IncomingMessage.emit (events.js:327:22) Apr 30 12:41:25 volumio volumio[926]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 30 12:41:25 volumio volumio[926]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 30 12:41:25 volumio volumio[926]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:41:26 volumio sudo[2229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-30 12:40 Apr 30 12:41:26 volumio sudo[2229]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"