-- Logs begin at Mon 2025-04-21 21:01:43 EEST, end at Wed 2025-04-23 08:26:05 EEST. -- Apr 23 08:25:04 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:04 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:05 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:05 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:07 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:07 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:09 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:09 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:10 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:10 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:12 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:12 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:13 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:13 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:15 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::ClearQueue Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::clearPlayQueue Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:15 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:15 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:15 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPlay Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::play index 0 Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::play index undefined Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:15 volumio volumio[962]: info: [1745385915238] ControllerUPNPBrowser::clearAddPlayTrack Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand stop took 4 milliseconds Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 08:25:15 volumio volumio[962]: info: Apr 23 08:25:15 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:15 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand clear took 1 milliseconds Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:15 volumio volumio[962]: error: updateQueue error: null Apr 23 08:25:15 volumio volumio[962]: info: ------------------------------ 2ms Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:15 volumio volumio[962]: info: Apr 23 08:25:15 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:15 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" took 1 milliseconds Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand play Apr 23 08:25:15 volumio volumio[962]: info: ------------------------------ 3ms Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand play took 1 milliseconds Apr 23 08:25:15 volumio volumio[962]: info: Apr 23 08:25:15 volumio volumio[962]: ---------------------------- MPD announces state update: player Apr 23 08:25:15 volumio volumio[962]: info: ControllerMpd::getState Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand status took 2 milliseconds Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::parseState Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand clearerror took 3 milliseconds Apr 23 08:25:15 volumio volumio[962]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 23 08:25:15 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Apr 23 08:25:15 volumio volumio[962]: info: ControllerMpd::pushState Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::servicePushState Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:15 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:15 volumio volumio[962]: 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":"101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","artist":null,"album":null,"uri":"http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","trackType":"aiff"} Apr 23 08:25:15 volumio volumio[962]: verbose: CURRENT POSITION 0 Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::syncState stateService stop Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus stop Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:15 volumio volumio[962]: info: No code Apr 23 08:25:15 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:15 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:15 volumio volumio[962]: info: ------------------------------ 18ms Apr 23 08:25:22 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::ClearQueue Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::clearPlayQueue Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:22 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:22 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:22 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPlay Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::play index 0 Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::play index undefined Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:22 volumio volumio[962]: info: [1745385922212] ControllerUPNPBrowser::clearAddPlayTrack Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand stop took 2 milliseconds Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 08:25:22 volumio volumio[962]: info: Apr 23 08:25:22 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:22 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand clear took 1 milliseconds Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:22 volumio volumio[962]: error: updateQueue error: null Apr 23 08:25:22 volumio volumio[962]: info: ------------------------------ 4ms Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:22 volumio volumio[962]: info: Apr 23 08:25:22 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:22 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" took 1 milliseconds Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand play Apr 23 08:25:22 volumio volumio[962]: info: ------------------------------ 2ms Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand play took 2 milliseconds Apr 23 08:25:22 volumio volumio[962]: info: Apr 23 08:25:22 volumio volumio[962]: ---------------------------- MPD announces state update: player Apr 23 08:25:22 volumio volumio[962]: info: ControllerMpd::getState Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand status took 2 milliseconds Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::parseState Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand clearerror took 2 milliseconds Apr 23 08:25:22 volumio volumio[962]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 23 08:25:22 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Apr 23 08:25:22 volumio volumio[962]: info: ControllerMpd::pushState Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::servicePushState Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:22 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:22 volumio volumio[962]: 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":"101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","artist":null,"album":null,"uri":"http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","trackType":"aiff"} Apr 23 08:25:22 volumio volumio[962]: verbose: CURRENT POSITION 0 Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::syncState stateService stop Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus stop Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:22 volumio volumio[962]: info: No code Apr 23 08:25:22 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:22 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:22 volumio volumio[962]: info: ------------------------------ 15ms Apr 23 08:25:28 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::ClearQueue Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::clearPlayQueue Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:28 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:28 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:28 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPlay Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::play index 0 Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::play index undefined Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:28 volumio volumio[962]: info: [1745385928107] ControllerUPNPBrowser::clearAddPlayTrack Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand stop took 3 milliseconds Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 08:25:28 volumio volumio[962]: info: Apr 23 08:25:28 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:28 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand clear took 2 milliseconds Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:28 volumio volumio[962]: error: updateQueue error: null Apr 23 08:25:28 volumio volumio[962]: info: ------------------------------ 3ms Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:28 volumio volumio[962]: info: Apr 23 08:25:28 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:28 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff" took 1 milliseconds Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand play Apr 23 08:25:28 volumio volumio[962]: info: ------------------------------ 3ms Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand play took 2 milliseconds Apr 23 08:25:28 volumio volumio[962]: info: Apr 23 08:25:28 volumio volumio[962]: ---------------------------- MPD announces state update: player Apr 23 08:25:28 volumio volumio[962]: info: ControllerMpd::getState Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand status took 3 milliseconds Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::parseState Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand clearerror took 1 milliseconds Apr 23 08:25:28 volumio volumio[962]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 23 08:25:28 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Apr 23 08:25:28 volumio volumio[962]: info: ControllerMpd::pushState Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::servicePushState Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:28 volumio volumio[962]: info: CorePlayQueue::getTrack 0 Apr 23 08:25:28 volumio volumio[962]: 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":"101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","artist":null,"album":null,"uri":"http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/101-martin_garrix_and_jay_hardway-wizard*20(16_44_1_DSD128*20PGGB).aiff","trackType":"aiff"} Apr 23 08:25:28 volumio volumio[962]: verbose: CURRENT POSITION 0 Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::syncState stateService stop Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus stop Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:28 volumio volumio[962]: info: No code Apr 23 08:25:28 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:28 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:28 volumio volumio[962]: info: ------------------------------ 20ms Apr 23 08:25:45 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:25:45 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:47 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::ClearQueue Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::clearPlayQueue Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:47 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1129 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1129 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20525 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20525 Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPlay Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::play index 2 Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:47 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i7728 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i7728 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18211 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18211 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18454 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18454 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i11604 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i11604 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5643 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5643 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i16616 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i16616 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i3761 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i3761 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20951 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20951 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19094 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19094 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i4030 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i4030 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10591 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10591 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1007 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1007 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18704 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18704 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14042 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14042 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20543 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20543 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14997 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14997 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6837 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6837 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5891 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5891 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15784 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15784 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19891 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19891 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i12992 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i12992 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14419 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14419 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10818 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10818 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19252 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19252 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15848 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15848 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2128 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2128 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14526 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14526 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i423 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i423 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9235 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9235 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1077 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1077 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8791 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8791 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9325 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9325 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10090 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10090 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8897 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8897 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5540 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5540 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6467 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6467 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8731 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8731 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i17136 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i17136 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20382 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20382 Apr 23 08:25:47 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2596 Apr 23 08:25:47 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2596 Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::play index undefined Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:47 volumio volumio[962]: info: [1745385947394] ControllerUPNPBrowser::clearAddPlayTrack Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand stop took 15 milliseconds Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 08:25:47 volumio volumio[962]: info: Apr 23 08:25:47 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:47 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand clear took 1 milliseconds Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:47 volumio volumio[962]: error: updateQueue error: null Apr 23 08:25:47 volumio volumio[962]: info: ------------------------------ 3ms Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:47 volumio volumio[962]: info: Apr 23 08:25:47 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:47 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" took 2 milliseconds Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand play Apr 23 08:25:47 volumio volumio[962]: info: ------------------------------ 2ms Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand play took 2 milliseconds Apr 23 08:25:47 volumio volumio[962]: info: Apr 23 08:25:47 volumio volumio[962]: ---------------------------- MPD announces state update: player Apr 23 08:25:47 volumio volumio[962]: info: ControllerMpd::getState Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand status took 2 milliseconds Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::parseState Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand clearerror took 2 milliseconds Apr 23 08:25:47 volumio volumio[962]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 23 08:25:47 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Apr 23 08:25:47 volumio volumio[962]: info: ControllerMpd::pushState Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::servicePushState Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:47 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:47 volumio volumio[962]: 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":"103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff","artist":null,"album":null,"uri":"http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff","trackType":"aiff"} Apr 23 08:25:47 volumio volumio[962]: verbose: CURRENT POSITION 2 Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::syncState stateService stop Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus stop Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:47 volumio volumio[962]: info: No code Apr 23 08:25:47 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:47 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:47 volumio volumio[962]: info: ------------------------------ 16ms Apr 23 08:25:51 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::ClearQueue Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::clearPlayQueue Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:51 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1128 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1129 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/folder/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$f1129 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20525 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20525 Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPlay Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::play index 2 Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::addQueueItems Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::addQueueItems Apr 23 08:25:51 volumio volumio[962]: info: Preload queue cleared Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i7728 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i7728 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18211 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18211 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18454 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18454 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i11604 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i11604 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5643 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5643 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i16616 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i16616 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i3761 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i3761 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20951 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20951 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19094 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19094 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i4030 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i4030 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10591 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10591 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1007 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1007 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18704 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i18704 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14042 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14042 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20543 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20543 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14997 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14997 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6837 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6837 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5891 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5891 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15784 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15784 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19891 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19891 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i12992 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i12992 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14419 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14419 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10818 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10818 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19252 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i19252 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15848 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i15848 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2128 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2128 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14526 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i14526 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i423 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i423 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9235 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9235 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1077 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i1077 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8791 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8791 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9325 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i9325 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10090 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i10090 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8897 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8897 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5540 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i5540 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6467 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i6467 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8731 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i8731 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i17136 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i17136 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20382 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i20382 Apr 23 08:25:51 volumio volumio[962]: info: Adding Item to queue: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2596 Apr 23 08:25:51 volumio volumio[962]: info: Using cached record of: upnp/http://192.168.1.98:9791/0c270146-89d4-4e02-acf5-5eb0e11e0d66/upnp.org-ContentDirectory-1/control@0$folders$f1$f1096$f1127$*i2596 Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::stop Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::saveQueue Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::play index undefined Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::updateTrackBlock Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::getTrackBlock Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:51 volumio volumio[962]: info: [1745385951498] ControllerUPNPBrowser::clearAddPlayTrack Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand stop took 10 milliseconds Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 08:25:51 volumio volumio[962]: info: Apr 23 08:25:51 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:51 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand clear took 0 milliseconds Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:51 volumio volumio[962]: error: updateQueue error: null Apr 23 08:25:51 volumio volumio[962]: info: ------------------------------ 2ms Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" Apr 23 08:25:51 volumio volumio[962]: info: Apr 23 08:25:51 volumio volumio[962]: ---------------------------- MPD announces system playlist update Apr 23 08:25:51 volumio volumio[962]: info: Ignoring MPD Status Update Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand add "http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff" took 1 milliseconds Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand play Apr 23 08:25:51 volumio volumio[962]: info: ------------------------------ 2ms Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand play took 1 milliseconds Apr 23 08:25:51 volumio volumio[962]: info: Apr 23 08:25:51 volumio volumio[962]: ---------------------------- MPD announces state update: player Apr 23 08:25:51 volumio volumio[962]: info: ControllerMpd::getState Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand status took 12 milliseconds Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::parseState Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand clearerror took 1 milliseconds Apr 23 08:25:51 volumio volumio[962]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 23 08:25:51 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Apr 23 08:25:51 volumio volumio[962]: info: ControllerMpd::pushState Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::servicePushState Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:51 volumio volumio[962]: info: CorePlayQueue::getTrack 2 Apr 23 08:25:51 volumio volumio[962]: 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":"103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff","artist":null,"album":null,"uri":"http://192.168.1.98:9790/minimserver/*/music/deep*20house*20obraboteni/CD-1/*d0*9d*d0*be*d0*b2*d0*b0*20*d0*bf*d0*b0*d0*bf*d0*ba*d0*b0/103-afrojack_feat._spree_wilson-the_spark*20(16_44_1_DSD128*20PGGB).aiff","trackType":"aiff"} Apr 23 08:25:51 volumio volumio[962]: verbose: CURRENT POSITION 2 Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::syncState stateService stop Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus stop Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:51 volumio volumio[962]: info: No code Apr 23 08:25:51 volumio volumio[962]: info: CoreStateMachine::pushState Apr 23 08:25:51 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Apr 23 08:25:51 volumio volumio[962]: info: ------------------------------ 21ms Apr 23 08:25:55 volumio sudo[12702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 23 08:25:55 volumio sudo[12702]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 08:25:55 volumio sudo[12705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 23 08:25:55 volumio sudo[12702]: pam_unix(sudo:session): session closed for user root Apr 23 08:25:55 volumio sudo[12705]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 08:25:55 volumio sudo[12705]: pam_unix(sudo:session): session closed for user root Apr 23 08:25:55 volumio volumio[962]: verbose: New Socket.io Connection to 192.168.1.93 from 192.168.1.98 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::volumioGetVisibleSources Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::volumioGetQueue Apr 23 08:25:55 volumio volumio[962]: info: CoreStateMachine::getQueue Apr 23 08:25:55 volumio volumio[962]: info: CorePlayQueue::getQueue Apr 23 08:25:55 volumio volumio[962]: info: Listing playlists Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 23 08:25:55 volumio volumio[962]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 23 08:25:55 volumio volumio[962]: info: Received Get System Info Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 08:25:55 volumio volumio[962]: info: Discovery: Getting this device information Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 23 08:25:55 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 08:25:57 volumio volumio[962]: info: Received Get System Info Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 08:25:57 volumio volumio[962]: info: Discovery: Getting this device information Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Apr 23 08:25:57 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 08:25:58 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 08:25:58 volumio volumio[962]: info: Received Get System Info Apr 23 08:25:58 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 08:25:58 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 08:25:58 volumio volumio[962]: info: Discovery: Getting this device information Apr 23 08:25:58 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Apr 23 08:25:58 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 08:26:00 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:26:01 volumio volumio[962]: info: Preload queue cleared Apr 23 08:26:02 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:26:02 volumio volumio[962]: info: Preload queue cleared Apr 23 08:26:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:26:03 volumio volumio[962]: info: Preload queue cleared Apr 23 08:26:05 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 23 08:26:05 volumio volumio[962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 08:26:05 volumio volumio[962]: TypeError: Cannot read property 'length' of undefined Apr 23 08:26:05 volumio volumio[962]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 23 08:26:05 volumio volumio[962]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 23 08:26:05 volumio volumio[962]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 23 08:26:05 volumio volumio[962]: at Parser.emit (events.js:400:28) Apr 23 08:26:05 volumio volumio[962]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 23 08:26:05 volumio volumio[962]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 23 08:26:05 volumio volumio[962]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 23 08:26:05 volumio volumio[962]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 23 08:26:05 volumio volumio[962]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 23 08:26:05 volumio volumio[962]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 23 08:26:05 volumio volumio[962]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 23 08:26:05 volumio volumio[962]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 23 08:26:05 volumio volumio[962]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 23 08:26:05 volumio volumio[962]: at IncomingMessage.emit (events.js:412:35) Apr 23 08:26:05 volumio volumio[962]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 23 08:26:05 volumio volumio[962]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 23 08:26:05 volumio volumio[962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 08:26:05 volumio sudo[12752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 08:25 Apr 23 08:26:05 volumio sudo[12752]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:14:40 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="a9bbde8819c9c7e405795a261e2a2f93"