-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2025-02-15 19:55:10 CET. -- Feb 15 19:54:09 volumio volumio[980]: info: MPD Database updated - AlbumList cache refreshed Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: database Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: MPD Database updated - AlbumList cache refreshed Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: database Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: MPD Database updated - AlbumList cache refreshed Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: database Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: Feb 15 19:54:09 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 81 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 79 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 80 milliseconds Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: info: Command Router : Notfying DB Updatetrue Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:09 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: No code Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:09 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: No code Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: ------------------------------ 178ms Feb 15 19:54:09 volumio volumio[980]: info: ------------------------------ 178ms Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 212 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 211 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 211 milliseconds Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: info: Command Router : Notfying DB Updatetrue Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:09 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: No code Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:09 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: No code Feb 15 19:54:09 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:09 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:09 volumio volumio[980]: info: ------------------------------ 291ms Feb 15 19:54:09 volumio volumio[980]: info: ------------------------------ 292ms Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 350 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 350 milliseconds Feb 15 19:54:09 volumio volumio[980]: info: sendMpdCommand status took 350 milliseconds Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: info: Command Router : Notfying DB Updatetrue Feb 15 19:54:09 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:09 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:10 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:10 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: No code Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:10 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: No code Feb 15 19:54:10 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:10 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:10 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:10 volumio volumio[980]: info: ------------------------------ 476ms Feb 15 19:54:10 volumio volumio[980]: info: ------------------------------ 477ms Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: info: Feb 15 19:54:15 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: info: Feb 15 19:54:15 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: info: Feb 15 19:54:15 volumio volumio[980]: ---------------------------- MPD announces state update: update Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::getState Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand status Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 3 milliseconds Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 3 milliseconds Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 3 milliseconds Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 2 milliseconds Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 2 milliseconds Feb 15 19:54:15 volumio volumio[980]: info: sendMpdCommand status took 1 milliseconds Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: info: Command Router : Notfying DB Updatefalse Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: info: Command Router : Notfying DB Updatefalse Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: info: Command Router : Notfying DB Updatefalse Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::Close All Modals sent Feb 15 19:54:15 volumio volumio[980]: verbose: ControllerMpd::parseState Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:15 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: No code Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:15 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: No code Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: ControllerMpd::pushState Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 15 19:54:15 volumio volumio[980]: verbose: CURRENT POSITION 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: No code Feb 15 19:54:15 volumio volumio[980]: info: CoreStateMachine::pushState Feb 15 19:54:15 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Feb 15 19:54:15 volumio volumio[980]: info: ------------------------------ 152ms Feb 15 19:54:15 volumio volumio[980]: info: ------------------------------ 152ms Feb 15 19:54:15 volumio volumio[980]: info: ------------------------------ 152ms Feb 15 19:54:18 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:54:18 volumio volumio[980]: info: Preload queue cleared Feb 15 19:54:22 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 19:54:22 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 19:54:22 volumio volumio[980]: info: Discovery: Getting this device information Feb 15 19:54:22 volumio volumio[980]: info: CoreCommandRouter::volumioGetState Feb 15 19:54:22 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:22 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 19:54:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:54:29 volumio volumio[980]: info: Preload queue cleared Feb 15 19:54:31 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:54:32 volumio volumio[980]: info: Preload queue cleared Feb 15 19:54:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:54:35 volumio volumio[980]: info: Preload queue cleared Feb 15 19:54:37 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:54:39 volumio volumio[980]: info: Preload queue cleared Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32358 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32378 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32401 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32425 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32448 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32469 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32491 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32512 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32533 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32564 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32364 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32382 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32405 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32436 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32452 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32482 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32510 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32518 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32549 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32572 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32602 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32614 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31606 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31676 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31599 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31854 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32075 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32233 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31782 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31719 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32159 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32046 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32339 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31981 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31598 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31857 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31724 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31605 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32363 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32392 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32408 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32429 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32453 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32481 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32499 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32527 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32538 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32574 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32230 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32207 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31795 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31615 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31613 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31939 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31614 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32170 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32235 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31865 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32000 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31694 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32186 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32240 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31941 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31627 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32175 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32239 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32006 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32241 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32263 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32238 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31688 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32365 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32395 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32407 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32445 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32455 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32485 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32496 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32531 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32537 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32568 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32590 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32601 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32615 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32622 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32629 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32051 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32062 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31859 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32300 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31933 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31727 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32153 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32351 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31725 Feb 15 19:54:39 volumio volumio[980]: info: Preloading song: upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31726 Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32358 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32378 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32401 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32425 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32448 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32469 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32491 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32512 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32533 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32564 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32364 in service upnp_browser Feb 15 19:54:39 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32382 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32405 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32436 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32452 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32482 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32510 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32518 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32549 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32572 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32602 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32614 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31606 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31676 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31599 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31854 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32075 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32233 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31782 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31719 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32159 in service upnp_browser Feb 15 19:54:40 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32046 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32339 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31981 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31598 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31857 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31724 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31605 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32363 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32392 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32408 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32429 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32453 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32481 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32499 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32527 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32538 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32574 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32230 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32207 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31795 in service upnp_browser Feb 15 19:54:41 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31615 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31613 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31939 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31614 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32170 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32235 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31865 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32000 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31694 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32186 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32240 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31941 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31627 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32175 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32239 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32006 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32241 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32263 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32238 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31688 in service upnp_browser Feb 15 19:54:42 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32365 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32395 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32407 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32445 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32455 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32485 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32496 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32531 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32537 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32568 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32590 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32601 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32615 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32622 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32629 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32051 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32062 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31859 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32300 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31933 in service upnp_browser Feb 15 19:54:43 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31727 in service upnp_browser Feb 15 19:54:44 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32153 in service upnp_browser Feb 15 19:54:44 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@32351 in service upnp_browser Feb 15 19:54:44 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31725 in service upnp_browser Feb 15 19:54:44 volumio volumio[980]: info: Exploding uri upnp/http://192.168.68.232:50001/ContentDirectory/control@22$@31726 in service upnp_browser Feb 15 19:54:52 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 19:54:52 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 19:54:52 volumio volumio[980]: info: Discovery: Getting this device information Feb 15 19:54:52 volumio volumio[980]: info: CoreCommandRouter::volumioGetState Feb 15 19:54:52 volumio volumio[980]: info: CorePlayQueue::getTrack 0 Feb 15 19:54:52 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 19:54:59 volumio volumio[980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Cats%20On%20Trees/Cats%20On%20Trees/f0e83e1c-02f4-41dd-96f1-c255ff9b3756.png' Feb 15 19:55:01 volumio volumio[980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Christine%20and%20the%20Queens/Chaleur%20humaine/30e6643e-5dca-46cb-8a2c-9959e1529940.png' Feb 15 19:55:02 volumio volumio[980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Christine%20and%20the%20Queens/Chaleur%20humaine/69f57c39-1b6d-49a4-b058-bd766204df73.png' Feb 15 19:55:05 volumio volumio[980]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Newton%20Howard/Collateral/c995f267-25c8-4c87-818b-e6da04cb2137.jpg' Feb 15 19:55:10 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 15 19:55:10 volumio volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 19:55:10 volumio volumio[980]: TypeError: Cannot read property 'length' of undefined Feb 15 19:55:10 volumio volumio[980]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Feb 15 19:55:10 volumio volumio[980]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Feb 15 19:55:10 volumio volumio[980]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Feb 15 19:55:10 volumio volumio[980]: at Parser.emit (events.js:315:20) Feb 15 19:55:10 volumio volumio[980]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Feb 15 19:55:10 volumio volumio[980]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Feb 15 19:55:10 volumio volumio[980]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Feb 15 19:55:10 volumio volumio[980]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Feb 15 19:55:10 volumio volumio[980]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Feb 15 19:55:10 volumio volumio[980]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Feb 15 19:55:10 volumio volumio[980]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Feb 15 19:55:10 volumio volumio[980]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Feb 15 19:55:10 volumio volumio[980]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Feb 15 19:55:10 volumio volumio[980]: at IncomingMessage.emit (events.js:327:22) Feb 15 19:55:10 volumio volumio[980]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 15 19:55:10 volumio volumio[980]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 15 19:55:10 volumio volumio[980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 19:55:10 volumio sudo[9669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 19:54 Feb 15 19:55:10 volumio sudo[9669]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"