-- Logs begin at Sun 2025-01-12 18:32:21 UTC, end at Mon 2025-01-13 17:31:37 UTC. -- Jan 13 17:30:05 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:30:05 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:07 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709165316 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708903172 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709427460 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709361924 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774570244 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709296388 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774439172 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709034244 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774504708 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709099780 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709230852 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709558532 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709492996 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708837636 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708968708 Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709165316 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708903172 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709427460 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709361924 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774570244 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709296388 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774439172 in service upnp_browser Jan 13 17:30:07 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709034244 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774504708 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709099780 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709230852 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709558532 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709492996 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708837636 in service upnp_browser Jan 13 17:30:08 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708968708 in service upnp_browser Jan 13 17:30:19 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::ClearQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::stPlaybackTimer Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 8 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::serviceStop Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 8 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::serviceStop Jan 13 17:30:19 volumiomarkus volumio[868]: info: [1736789419065] ControllerUPNPBrowser::stop Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::clearPlayQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::addQueueItems Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::addQueueItems Jan 13 17:30:19 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709165316 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709165316 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708903172 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708903172 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709427460 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709427460 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709361924 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709361924 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774570244 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774570244 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709296388 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709296388 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774439172 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774439172 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709034244 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709034244 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774504708 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$774504708 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709099780 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709099780 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709230852 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709230852 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPlay Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::play index 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::addQueueItems Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::addQueueItems Jan 13 17:30:19 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709558532 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709558532 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709492996 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$709492996 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708837636 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708837636 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708968708 Jan 13 17:30:19 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$72483093$72548629$708968708 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::play index undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::startPlaybackTimer Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: [1736789419088] ControllerUPNPBrowser::clearAddPlayTrack Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand stop took 37 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand stop took 14 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand status took 1 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:30:19 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand clear took 27 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 26 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac" Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:30:19 volumiomarkus volumio[868]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 31ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 13 17:30:19 volumiomarkus volumio[868]: error: updateQueue error: null Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 90ms Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac" Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:30:19 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac" took 0 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand play Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 1ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand play took 1 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand status took 1 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand status took 2 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"x-flac,pn=,ext=.flac","artist":null,"album":null,"uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac","trackType":"flac"} Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: CURRENT POSITION 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus stop Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 5ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"x-flac,pn=,ext=.flac","artist":null,"album":null,"uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac","trackType":"flac"} Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: CURRENT POSITION 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:30:19 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 12ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:30:19 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:30:19 volumiomarkus volumio[868]: info: Jan 13 17:30:19 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 2ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand status took 6 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"791 Kbps","isStreaming":false,"title":"Man Smart (Woman Smarter)","artist":"Harry Belafonte","album":"Belafonte at Carnegie Hall","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac","trackType":"flac"} Jan 13 17:30:19 volumiomarkus volumio[868]: verbose: CURRENT POSITION 10 Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:30:19 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:30:19 volumiomarkus volumio[868]: info: ------------------------------ 41ms Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:30:19 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:30:53 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:30:53 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:58 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142213380 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142278916 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142344452 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88736004 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142409988 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142475524 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142541060 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142606596 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142672132 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142737668 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142803204 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142868740 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88801540 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142934276 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142999812 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143065348 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143130884 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Preloading song: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143196420 Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142213380 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142278916 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142344452 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88736004 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142409988 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142475524 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142541060 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142606596 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142672132 in service upnp_browser Jan 13 17:30:58 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142737668 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142803204 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142868740 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88801540 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142934276 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142999812 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143065348 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143130884 in service upnp_browser Jan 13 17:30:59 volumiomarkus volumio[868]: info: Exploding uri upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143196420 in service upnp_browser Jan 13 17:31:01 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::ClearQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::stPlaybackTimer Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::serviceStop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::serviceStop Jan 13 17:31:01 volumiomarkus volumio[868]: info: [1736789461197] ControllerUPNPBrowser::stop Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::clearPlayQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::addQueueItems Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::addQueueItems Jan 13 17:31:01 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:01 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/folder/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781 Jan 13 17:31:01 volumiomarkus volumio[868]: info: Exploding uri upnp/folder/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781 in service upnp_browser Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand stop took 39 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand status took 1 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Man Smart (Woman Smarter)","artist":"Harry Belafonte","album":"Belafonte at Carnegie Hall","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$72483093$72548629$709230852.flac?type=1,client=33,mime=audio/x-flac,pn=,ext=.flac","trackType":"flac"} Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: CURRENT POSITION 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: No code Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 10 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 20ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPlay Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::play index 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::play index undefined Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::startPlaybackTimer Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: [1736789461301] ControllerUPNPBrowser::clearAddPlayTrack Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand stop took 9 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:01 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand clear took 1 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" Jan 13 17:31:01 volumiomarkus volumio[868]: error: updateQueue error: null Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 74ms Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" Jan 13 17:31:01 volumiomarkus volumio[868]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:01 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" took 2 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand play Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 3ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand play took 2 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand status took 4 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand status took 2 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: CURRENT POSITION 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus stop Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 12ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:01 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:01 volumiomarkus volumio[868]: info: Jan 13 17:31:01 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AudioTrack 01","artist":"Herr der Ringe","album":"Die Gefährten","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: CURRENT POSITION 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:01 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 26ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 19ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand status took 19 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 62 milliseconds Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AudioTrack 01","artist":"Herr der Ringe","album":"Die Gefährten","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:01 volumiomarkus volumio[868]: verbose: CURRENT POSITION 0 Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:01 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:01 volumiomarkus volumio[868]: info: ------------------------------ 99ms Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:01 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioSeek Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::seek Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:03 volumiomarkus volumio[868]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","realUri":"upnp/folder/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781","type":"song","albumart":"http://192.168.1.27:8200/Thumbnails/A01/share/CACHEDEV1_DATA/.system/thumbnail/07a/2170.jpg","artist":"Herr der Ringe","album":"Die Gefährten","name":"AudioTrack 01","title":"AudioTrack 01","duration":235} Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::startPlaybackTimer Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:03 volumiomarkus volumio[868]: info: [1736789463936] ControllerUPNPBrowser::seek Jan 13 17:31:03 volumiomarkus volumio[868]: info: ControllerMpd::seek Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: error: null Jan 13 17:31:03 volumiomarkus volumio[868]: info: Jan 13 17:31:03 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:03 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:03 volumiomarkus volumio[868]: info: sendMpdCommand status took 1 milliseconds Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:03 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:03 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42880,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AudioTrack 01","artist":"Herr der Ringe","album":"Die Gefährten","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$142213380.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:03 volumiomarkus volumio[868]: verbose: CURRENT POSITION 0 Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:03 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:03 volumiomarkus volumio[868]: info: ------------------------------ 10ms Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:03 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::ClearQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::stPlaybackTimer Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::serviceStop Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 0 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::serviceStop Jan 13 17:31:09 volumiomarkus volumio[868]: info: [1736789469609] ControllerUPNPBrowser::stop Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::clearPlayQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::addQueueItems Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::addQueueItems Jan 13 17:31:09 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142213380 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142213380 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142278916 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142278916 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142344452 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142344452 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88736004 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88736004 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142409988 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142409988 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142475524 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142475524 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142541060 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142541060 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142606596 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142606596 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142672132 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142672132 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142737668 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142737668 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142803204 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142803204 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142868740 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142868740 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88801540 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$88801540 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142934276 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142934276 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142999812 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$142999812 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143065348 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143065348 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143130884 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143130884 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Adding Item to queue: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143196420 Jan 13 17:31:09 volumiomarkus volumio[868]: info: Using cached record of: upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143196420 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::saveQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::updateTrackBlock Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrackBlock Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPlay Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::play index 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::stop Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::play index undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::startPlaybackTimer Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: [1736789469629] ControllerUPNPBrowser::clearAddPlayTrack Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand stop took 32 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand stop took 13 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand status took 2 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:09 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand clear took 26 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:09 volumiomarkus volumio[868]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 29ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 13 17:31:09 volumiomarkus volumio[868]: error: updateQueue error: null Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 65ms Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:09 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand add "http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3" took 1 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand play Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 1ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand play took 1 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand status took 2 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand status took 2 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: CURRENT POSITION 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus stop Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 7ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mpeg,pn=MP3,ext=.mp3","artist":null,"album":null,"uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: CURRENT POSITION 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:09 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 21ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces system playlist update Jan 13 17:31:09 volumiomarkus volumio[868]: info: Ignoring MPD Status Update Jan 13 17:31:09 volumiomarkus volumio[868]: info: Jan 13 17:31:09 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 23ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand status took 21 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":260,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AudioTrack 18","artist":"Herr der Ringe","album":"Die Gefährten","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:09 volumiomarkus volumio[868]: verbose: CURRENT POSITION 17 Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:09 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:09 volumiomarkus volumio[868]: info: ------------------------------ 59ms Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:09 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioSeek Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::seek Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:11 volumiomarkus volumio[868]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","realUri":"upnp/http://192.168.1.27:8200/ctl/ContentDir@A0$128$146$65813$983317$33751317$17236245$17301781$143196420","type":"song","albumart":"http://192.168.1.27:8200/Thumbnails/A01/share/CACHEDEV1_DATA/.system/thumbnail/089/2185.jpg","artist":"Herr der Ringe","album":"Die Gefährten","name":"AudioTrack 18","title":"AudioTrack 18","duration":259} Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::startPlaybackTimer Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:11 volumiomarkus volumio[868]: info: [1736789471901] ControllerUPNPBrowser::seek Jan 13 17:31:11 volumiomarkus volumio[868]: info: ControllerMpd::seek Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:11 volumiomarkus volumio[868]: error: null Jan 13 17:31:11 volumiomarkus volumio[868]: info: Jan 13 17:31:11 volumiomarkus volumio[868]: ---------------------------- MPD announces state update: player Jan 13 17:31:11 volumiomarkus volumio[868]: info: ControllerMpd::getState Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand status Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: sendMpdCommand status took 23 milliseconds Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: ControllerMpd::parseState Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 17:31:11 volumiomarkus volumio[868]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: ControllerMpd::parseTrackInfo Jan 13 17:31:11 volumiomarkus volumio[868]: info: ControllerMpd::pushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::servicePushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getTrack 17 Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29000,"duration":260,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"AudioTrack 18","artist":"Herr der Ringe","album":"Die Gefährten","uri":"http://192.168.1.27:8200/MediaItems/A0$128$146$65813$983317$33751317$17236245$17301781$143196420.mp3?type=1,client=33,mime=audio/mpeg,pn=MP3,ext=.mp3","trackType":"mp3"} Jan 13 17:31:11 volumiomarkus volumio[868]: verbose: CURRENT POSITION 17 Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::syncState stateService play Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::syncState currentStatus play Jan 13 17:31:11 volumiomarkus volumio[868]: info: Received an update from plugin. extracting info from payload Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::pushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioPushState Jan 13 17:31:11 volumiomarkus volumio[868]: info: ------------------------------ 35ms Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreCommandRouter::volumioGetQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CoreStateMachine::getQueue Jan 13 17:31:11 volumiomarkus volumio[868]: info: CorePlayQueue::getQueue Jan 13 17:31:29 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:31:29 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:35 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:31:35 volumiomarkus volumio[868]: info: Preload queue cleared Jan 13 17:31:36 volumiomarkus volumio[868]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 13 17:31:36 volumiomarkus volumio[868]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 17:31:36 volumiomarkus volumio[868]: TypeError: Cannot read property 'length' of undefined Jan 13 17:31:36 volumiomarkus volumio[868]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jan 13 17:31:36 volumiomarkus volumio[868]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jan 13 17:31:36 volumiomarkus volumio[868]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jan 13 17:31:36 volumiomarkus volumio[868]: at Parser.emit (events.js:315:20) Jan 13 17:31:36 volumiomarkus volumio[868]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jan 13 17:31:36 volumiomarkus volumio[868]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jan 13 17:31:36 volumiomarkus volumio[868]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jan 13 17:31:36 volumiomarkus volumio[868]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jan 13 17:31:36 volumiomarkus volumio[868]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jan 13 17:31:36 volumiomarkus volumio[868]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jan 13 17:31:36 volumiomarkus volumio[868]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jan 13 17:31:36 volumiomarkus volumio[868]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jan 13 17:31:36 volumiomarkus volumio[868]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jan 13 17:31:36 volumiomarkus volumio[868]: at IncomingMessage.emit (events.js:327:22) Jan 13 17:31:36 volumiomarkus volumio[868]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 13 17:31:36 volumiomarkus volumio[868]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 13 17:31:36 volumiomarkus volumio[868]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 17:31:37 volumiomarkus sudo[23562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-13 17:30 Jan 13 17:31:37 volumiomarkus sudo[23562]: 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"