-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Tue 2026-02-24 22:25:16 EST. -- Feb 24 22:24:09 volumio volumio[985]: info: CorePlayQueue::getTrack 1 Feb 24 22:24:09 volumio volumio[985]: info: CorePlayQueue::getTrack 2 Feb 24 22:24:09 volumio volumio[985]: info: Prefetching next song Feb 24 22:24:09 volumio volumio[985]: info: Doing Prefetch in UPNP Feb 24 22:24:09 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14511.wav?format=WAV&downsample=false" Feb 24 22:24:09 volumio volumio[985]: info: sendMpdCommand add "http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14511.wav?format=WAV&downsample=false" took 1 milliseconds Feb 24 22:24:09 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 24 22:24:09 volumio volumio[985]: info: Feb 24 22:24:09 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:09 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:09 volumio volumio[985]: info: Feb 24 22:24:09 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:09 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:09 volumio volumio[985]: info: Feb 24 22:24:09 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:09 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:09 volumio volumio[985]: info: sendMpdCommand consume 1 took 6 milliseconds Feb 24 22:24:09 volumio volumio[985]: info: ------------------------------ 6ms Feb 24 22:24:09 volumio volumio[985]: info: ------------------------------ 5ms Feb 24 22:24:09 volumio volumio[985]: info: ------------------------------ 3ms Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPlay Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::play index 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::stop Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::stPlaybackTimer Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::updateTrackBlock Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrackBlock Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 1 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::serviceStop Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 1 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::serviceStop Feb 24 22:24:12 volumio volumio[985]: info: [1771989852353] ControllerUPNPBrowser::stop Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand stop took 19 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::play index undefined Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: [1771989852374] ControllerUPNPBrowser::clearAddPlayTrack Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:12 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand stop took 1 milliseconds Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:12 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:12 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand status took 7 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand clear took 6 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand status took 5 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand status took 3 milliseconds Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false" Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:12 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: 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 24 22:24:12 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::syncState stateService stop Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus stop Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: No code Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: 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 24 22:24:12 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::syncState stateService stop Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus stop Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: No code Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:12 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:12 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 71ms Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 70ms Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: error: updateQueue error: null Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 74ms Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand playlistinfo took 71 milliseconds Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:12 volumio volumio[985]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 84ms Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false" Feb 24 22:24:12 volumio volumio[985]: error: updateQueue error: null Feb 24 22:24:12 volumio volumio[985]: error: updateQueue error: null Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 212ms Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 211ms Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand add "http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false" took 3 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 24 22:24:12 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand play Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: info: Feb 24 22:24:12 volumio volumio[985]: ---------------------------- MPD announces system playlist update Feb 24 22:24:12 volumio volumio[985]: info: Ignoring MPD Status Update Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 10ms Feb 24 22:24:12 volumio volumio[985]: info: sendMpdCommand play took 9 milliseconds Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 7ms Feb 24 22:24:12 volumio volumio[985]: info: ------------------------------ 6ms Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 7 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 5 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 4 milliseconds Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: Feb 24 22:24:13 volumio volumio[985]: ---------------------------- MPD announces state update: player Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::getState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand status Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 10 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 5 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand status took 3 milliseconds Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseState Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus stop Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Feb 24 22:24:13 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Feb 24 22:24:13 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 47ms Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 79ms Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 78ms Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 64 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 63 milliseconds Feb 24 22:24:13 volumio volumio[985]: info: sendMpdCommand playlistinfo took 63 milliseconds Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: verbose: ControllerMpd::parseTrackInfo Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Feb 24 22:24:13 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Feb 24 22:24:13 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: ControllerMpd::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::servicePushState Feb 24 22:24:13 volumio volumio[985]: info: CorePlayQueue::getTrack 13 Feb 24 22:24:13 volumio volumio[985]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"id=14518.wav?format=WAV&downsample=false","artist":null,"album":null,"uri":"http://192.168.2.100:50002/transcoder/genericoder.cgi/id=14518.wav?format=WAV&downsample=false","trackType":""} Feb 24 22:24:13 volumio volumio[985]: verbose: CURRENT POSITION 13 Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState stateService play Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::syncState currentStatus play Feb 24 22:24:13 volumio volumio[985]: info: Received an update from plugin. extracting info from payload Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: CoreStateMachine::pushState Feb 24 22:24:13 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 166ms Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 160ms Feb 24 22:24:13 volumio volumio[985]: info: ------------------------------ 159ms Feb 24 22:24:40 volumio sudo[3389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 24 22:24:40 volumio sudo[3389]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 22:24:40 volumio sudo[3389]: pam_unix(sudo:session): session closed for user root Feb 24 22:24:40 volumio sudo[3391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 24 22:24:40 volumio sudo[3391]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 24 22:24:40 volumio sudo[3391]: pam_unix(sudo:session): session closed for user root Feb 24 22:24:40 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.2.77 from 192.168.2.205 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 24 22:24:41 volumio volumio[985]: info: Listing playlists Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 22:24:41 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 24 22:24:45 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources Feb 24 22:24:45 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 24 22:24:45 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue Feb 24 22:24:45 volumio volumio[985]: info: CoreStateMachine::getQueue Feb 24 22:24:45 volumio volumio[985]: info: CorePlayQueue::getQueue Feb 24 22:24:52 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 24 22:24:52 volumio volumio[985]: info: Preload queue cleared Feb 24 22:24:53 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 24 22:24:54 volumio volumio[985]: info: Preload queue cleared Feb 24 22:24:55 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 24 22:24:55 volumio volumio[985]: info: Preload queue cleared Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 24 22:24:59 volumio volumio[985]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 24 22:24:59 volumio volumio[985]: info: Received Get System Version Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 22:24:59 volumio volumio[985]: info: Received Get System Info Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 22:24:59 volumio volumio[985]: info: Discovery: Getting this device information Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 24 22:24:59 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 22:25:00 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 24 22:25:03 volumio volumio[985]: Cannot compose Albumart path Feb 24 22:25:03 volumio volumio[985]: Cannot compose Albumart path Feb 24 22:25:03 volumio volumio[985]: Cannot compose Albumart path Feb 24 22:25:03 volumio volumio[985]: Cannot compose Albumart path Feb 24 22:25:03 volumio volumio[985]: Cannot compose Albumart path Feb 24 22:25:03 volumio volumio[985]: info: Preload queue cleared Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14806 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14815 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14808 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14813 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14811 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14810 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14804 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14812 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14814 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14809 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14805 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14807 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18322 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18328 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18323 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18333 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18317 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18334 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18314 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18326 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18312 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18327 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18319 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18332 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18313 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18324 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18320 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18329 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18315 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18330 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18318 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18325 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18321 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18331 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18316 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18335 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18366 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16735 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16726 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16731 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16734 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16733 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16729 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16730 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16732 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16736 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16728 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16737 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16727 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16002 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16001 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15998 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16003 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15995 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15993 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15996 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15999 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16000 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15994 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15997 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15509 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15504 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15500 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15505 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15507 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15499 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15503 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15506 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15508 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15502 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15501 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17169 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17163 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17175 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17166 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17174 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17171 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17165 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17167 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17173 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17162 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17172 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17170 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17164 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17168 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15750 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15742 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15746 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15752 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15744 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15751 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15753 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15745 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15748 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15749 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15747 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15743 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15760 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15764 Feb 24 22:25:03 volumio volumio[985]: info: Preloading song: upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15757 Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14806 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14815 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14808 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14813 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14811 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14810 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14804 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14812 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14814 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14809 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14805 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sting/...Nothing%20Like%20The%20Sun/6dfc98cb-6c03-4705-9be7-2a05cc418196.png' Feb 24 22:25:03 volumio volumio[985]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sting/...Nothing%20Like%20The%20Sun/6dfc98cb-6c03-4705-9be7-2a05cc418196.png' Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@14807 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18322 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18328 in service upnp_browser Feb 24 22:25:03 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18323 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18333 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18317 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18334 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18314 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18326 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18312 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18327 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18319 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18332 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18313 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18324 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18320 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18329 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18315 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18330 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18318 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18325 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18321 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18331 in service upnp_browser Feb 24 22:25:04 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18316 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18335 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@18366 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16735 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16726 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16731 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16734 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16733 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16729 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16730 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16732 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16736 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16728 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16737 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16727 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16002 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16001 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15998 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16003 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15995 in service upnp_browser Feb 24 22:25:05 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15993 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15996 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15999 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@16000 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15994 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15997 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15509 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15504 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15500 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15505 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15507 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15499 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15503 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15506 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15508 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15502 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15501 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17169 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17163 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17175 in service upnp_browser Feb 24 22:25:06 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17166 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17174 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17171 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17165 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17167 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17173 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17162 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17172 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17170 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17164 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@17168 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15750 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15742 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15746 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15752 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15744 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15751 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15753 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15745 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15748 in service upnp_browser Feb 24 22:25:07 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15749 in service upnp_browser Feb 24 22:25:08 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15747 in service upnp_browser Feb 24 22:25:08 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15743 in service upnp_browser Feb 24 22:25:08 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15760 in service upnp_browser Feb 24 22:25:08 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15764 in service upnp_browser Feb 24 22:25:08 volumio volumio[985]: info: Exploding uri upnp/http://192.168.2.100:50001/ContentDirectory/control@23$@15757 in service upnp_browser Feb 24 22:25:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 24 22:25:14 volumio volumio[985]: info: Preload queue cleared Feb 24 22:25:16 volumio volumio[985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 22:25:16 volumio volumio[985]: TypeError: Cannot read property 'slice' of null Feb 24 22:25:16 volumio volumio[985]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 24 22:25:16 volumio volumio[985]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 24 22:25:16 volumio volumio[985]: at Object.onceWrapper (events.js:422:26) Feb 24 22:25:16 volumio volumio[985]: at ClientRequest.emit (events.js:315:20) Feb 24 22:25:16 volumio volumio[985]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Feb 24 22:25:16 volumio volumio[985]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Feb 24 22:25:16 volumio volumio[985]: at TLSSocket.socketOnData (_http_client.js:509:22) Feb 24 22:25:16 volumio volumio[985]: at TLSSocket.emit (events.js:315:20) Feb 24 22:25:16 volumio volumio[985]: at addChunk (internal/streams/readable.js:309:12) Feb 24 22:25:16 volumio volumio[985]: at readableAddChunk (internal/streams/readable.js:284:9) Feb 24 22:25:16 volumio volumio[985]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Feb 24 22:25:16 volumio volumio[985]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Feb 24 22:25:16 volumio volumio[985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 22:25:16 volumio sudo[3529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-24 22:24 Feb 24 22:25:16 volumio sudo[3529]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"