-- Logs begin at Fri 2025-03-14 15:47:15 UTC, end at Sat 2025-03-15 15:10:03 UTC. -- Mar 15 15:09:00 volumio volumio[4677]: info: Preload queue cleared Mar 15 15:09:01 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 15 15:09:02 volumio volumio[4677]: info: Preload queue cleared Mar 15 15:09:04 volumio volumio[4677]: info: CoreStateMachine::startPlaybackTimer Mar 15 15:09:04 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:04 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:04 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:04 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:04 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:04 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:04 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:04 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 3ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 3ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 2ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 1 milliseconds Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":280079,"duration":280,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Scream of a Butterfly","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3553.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":280079,"duration":280,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Scream of a Butterfly","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3553.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 42ms Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 41ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":280079,"duration":280,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Scream of a Butterfly","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3553.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 50ms Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces system playlist update Mar 15 15:09:05 volumio volumio[4677]: info: Ignoring MPD Status Update Mar 15 15:09:05 volumio volumio[4677]: info: Mar 15 15:09:05 volumio volumio[4677]: ---------------------------- MPD announces state update: player Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 9ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 8 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 9ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 8 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 3ms Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 15 15:09:05 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:05 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:05 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 41ms Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 41ms Mar 15 15:09:05 volumio volumio[4677]: info: ------------------------------ 35ms Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:05 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:05 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:06 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 15 15:09:06 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 15 15:09:06 volumio volumio[4677]: info: Discovery: Getting this device information Mar 15 15:09:06 volumio volumio[4677]: info: CoreCommandRouter::volumioGetState Mar 15 15:09:06 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:06 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 15 15:09:08 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 15 15:09:08 volumio volumio[4677]: info: Preload queue cleared Mar 15 15:09:25 volumio volumio[4677]: info: CoreCommandRouter::volumioGetState Mar 15 15:09:25 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:36 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 15 15:09:36 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 15 15:09:36 volumio volumio[4677]: info: Discovery: Getting this device information Mar 15 15:09:36 volumio volumio[4677]: info: CoreCommandRouter::volumioGetState Mar 15 15:09:36 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:36 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 15 15:09:39 volumio volumio[4677]: info: CoreCommandRouter::volumioGetState Mar 15 15:09:39 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: info: Retrieving Cloud Streaming UI Mar 15 15:09:42 volumio volumio[4677]: info: Getting Tidal Cloud Configuration Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: info: Getting Qobuz Cloud Configuration Mar 15 15:09:42 volumio volumio[4677]: info: Asking plugin for UI Config Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: info: Getting Spotify Cloud Configuration Mar 15 15:09:42 volumio volumio[4677]: info: Asking plugin for UI Config Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: info: Saving Spotify Acccount Mar 15 15:09:42 volumio volumio[4677]: info: Got Tidal Cloud Configuration Mar 15 15:09:42 volumio volumio[4677]: info: Got it Mar 15 15:09:42 volumio volumio[4677]: info: Got it Mar 15 15:09:42 volumio volumio[4677]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 15 15:09:42 volumio volumio[4677]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::volumioGetBrowseSources Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::volumioGetBrowseSources Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::volumioGetBrowseSources Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:09:42 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 15 15:09:46 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand update Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand update took 2 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 1 milliseconds Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 61 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 60 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42091,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 145ms Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: Mar 15 15:09:47 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 79 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 57 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 39 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 19 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 18 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 18 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand status took 18 milliseconds Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42091,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42182,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42182,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 258ms Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 200ms Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 199ms Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 15 15:09:47 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 35 milliseconds Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42182,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42182,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:47 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:47 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 143ms Mar 15 15:09:47 volumio volumio[4677]: info: ------------------------------ 141ms Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:47 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:47 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:50 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand rescan Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand rescan took 2 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 5 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 4 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 4 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatetrue Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: Mar 15 15:09:51 volumio volumio[4677]: ---------------------------- MPD announces state update: update Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::getState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand status Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 96 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 95 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 51 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 4 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 4 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 3 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand status took 2 milliseconds Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: info: Command Router : Notfying DB Updatefalse Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::Close All Modals sent Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseState Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 195ms Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 193ms Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 193ms Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 116 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 97 milliseconds Mar 15 15:09:51 volumio volumio[4677]: info: sendMpdCommand playlistinfo took 78 milliseconds Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: verbose: ControllerMpd::parseTrackInfo Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ControllerMpd::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::servicePushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46388,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Want you","artist":"Supermax","album":"Something in My Heart","uri":"http://192.168.0.1:8200/MediaItems/3554.mp3","trackType":"mp3"} Mar 15 15:09:51 volumio volumio[4677]: verbose: CURRENT POSITION 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState stateService play Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::syncState currentStatus play Mar 15 15:09:51 volumio volumio[4677]: info: Received an update from plugin. extracting info from payload Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::pushState Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getTrack 4 Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioPushState Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 272ms Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 180ms Mar 15 15:09:51 volumio volumio[4677]: info: ------------------------------ 180ms Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreCommandRouter::volumioGetQueue Mar 15 15:09:51 volumio volumio[4677]: info: CoreStateMachine::getQueue Mar 15 15:09:51 volumio volumio[4677]: info: CorePlayQueue::getQueue Mar 15 15:09:54 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:09:58 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:10:02 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 15 15:10:02 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 15 15:10:02 volumio volumio[4677]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 15 15:10:02 volumio volumio[4677]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 15:10:02 volumio volumio[4677]: Error: getaddrinfo -3007 Mar 15 15:10:02 volumio volumio[4677]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 15 15:10:02 volumio volumio[4677]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 15 15:10:02 volumio volumio[4677]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 15 15:10:02 volumio volumio[4677]: code: -3007, Mar 15 15:10:02 volumio volumio[4677]: errno: -3007, Mar 15 15:10:02 volumio volumio[4677]: syscall: 'getaddrinfo' Mar 15 15:10:02 volumio volumio[4677]: } Mar 15 15:10:02 volumio volumio[4677]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 15:10:03 volumio sudo[7391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 15:09 Mar 15 15:10:03 volumio sudo[7391]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"