-- Logs begin at Tue 2025-06-24 16:21:38 +04, end at Tue 2025-06-24 17:12:56 +04. -- Jun 24 17:11:04 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 24 17:11:04 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 17:11:04 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 24 17:11:04 test volumio[11076]: error: Could not retrieve plugin system_controller my_volumio Jun 24 17:12:02 test CRON[11531]: pam_unix(cron:session): session opened for user root by (uid=0) Jun 24 17:12:02 test CRON[11532]: (root) CMD (/root/sycfm/bin/mp-sw.sh 2) Jun 24 17:12:02 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:02 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:02 test volumio[11076]: info: CoreCommandRouter::volumioGetQueue Jun 24 17:12:02 test volumio[11076]: info: CoreStateMachine::getQueue Jun 24 17:12:02 test volumio[11076]: info: CorePlayQueue::getQueue Jun 24 17:12:03 test volumio[11076]: info: CoreCommandRouter::volumioGetQueue Jun 24 17:12:03 test volumio[11076]: info: CoreStateMachine::getQueue Jun 24 17:12:03 test volumio[11076]: info: CorePlayQueue::getQueue Jun 24 17:12:03 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:03 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:03 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:03 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:03 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:03 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:08 test volumio[11076]: info: VolumeController::SetAlsaVolume22 Jun 24 17:12:08 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:08 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:08 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:08 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:08 test volumio[11076]: info: VolumeController::SetAlsaVolume25 Jun 24 17:12:08 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:08 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:08 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:08 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:08 test cron[592]: 2025-06-24 17:12:08 1uU3RY-00031d-Ps Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jun 24 17:12:08 test cron[592]: 2025-06-24 17:12:08 1uU3RY-00031d-Ps <= root@volumio U=root P=local S=2615 Jun 24 17:12:08 test cron[592]: 2025-06-24 17:12:08 1uU3RY-00031d-Ps Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jun 24 17:12:08 test cron[592]: exim: could not open panic log - aborting: see message(s) above Jun 24 17:12:08 test exim[11633]: 2025-06-24 17:12:08 1uU3RY-00031d-Ps <= root@volumio U=root P=local S=2615 Jun 24 17:12:08 test exim[11633]: 2025-06-24 17:12:08 1uU3RY-00031d-Ps Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jun 24 17:12:08 test exim[11633]: exim: could not open panic log - aborting: see message(s) above Jun 24 17:12:08 test CRON[11531]: (root) MAIL (mailed 2068 bytes of output but got status 0x0001 from MTA ) Jun 24 17:12:08 test CRON[11531]: pam_unix(cron:session): session closed for user root Jun 24 17:12:10 test volumio[11076]: info: VolumeController::SetAlsaVolume0 Jun 24 17:12:10 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:10 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:10 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:10 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:11 test volumio[11076]: info: VolumeController::SetAlsaVolume95 Jun 24 17:12:11 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:11 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:11 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:11 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:16 test volumio[11076]: info: VolumeController::SetAlsaVolume86 Jun 24 17:12:16 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:16 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:16 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:16 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:16 test volumio[11076]: info: VolumeController::SetAlsaVolume83 Jun 24 17:12:17 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:17 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:17 test volumio[11076]: info: VolumeController::SetAlsaVolume79 Jun 24 17:12:17 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:17 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:17 test volumio[11076]: info: VolumeController::SetAlsaVolume78 Jun 24 17:12:17 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:17 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:17 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:22 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 24 17:12:22 test volumio[11076]: info: CURURI: music-library Jun 24 17:12:22 test volumio[11076]: info: Preload queue cleared Jun 24 17:12:22 test volumio[11076]: info: Preloading song: music-library/4 Jun 24 17:12:22 test volumio[11076]: info: Preloading song: music-library/3 Jun 24 17:12:22 test volumio[11076]: info: Preloading song: music-library/2 Jun 24 17:12:22 test volumio[11076]: info: Preloading song: music-library/1 Jun 24 17:12:22 test volumio[11076]: info: Exploding uri music-library/4 in service mpd Jun 24 17:12:22 test volumio[11076]: error: scanFolder - failure to stat '/mnt/4' Jun 24 17:12:22 test volumio[11076]: info: Exploding uri music-library/3 in service mpd Jun 24 17:12:22 test volumio[11076]: error: scanFolder - failure to stat '/mnt/3' Jun 24 17:12:22 test volumio[11076]: info: Exploding uri music-library/2 in service mpd Jun 24 17:12:22 test volumio[11076]: error: scanFolder - failure to stat '/mnt/2' Jun 24 17:12:22 test volumio[11076]: info: Exploding uri music-library/1 in service mpd Jun 24 17:12:22 test volumio[11076]: error: scanFolder - failure to stat '/mnt/1' Jun 24 17:12:29 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 24 17:12:29 test volumio[11076]: info: CURURI: music-library/INTERNAL Jun 24 17:12:29 test volumio[11076]: info: Preload queue cleared Jun 24 17:12:40 test volumio[11076]: info: Preload queue cleared Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::ClearQueue Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::stop Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::stPlaybackTimer Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::updateTrackBlock Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::getTrackBlock Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::serviceStop Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::serviceStop Jun 24 17:12:40 test volumio[11076]: info: ControllerMpd::stop Jun 24 17:12:40 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::clearPlayQueue Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::saveQueue Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::volumioPushQueue Jun 24 17:12:40 test volumio[11076]: info: CoreStateMachine::addQueueItems Jun 24 17:12:40 test volumio[11076]: info: CorePlayQueue::addQueueItems Jun 24 17:12:40 test volumio[11076]: info: Preload queue cleared Jun 24 17:12:40 test volumio[11076]: info: Adding Item to queue: music-library/INTERNAL/1 Japanese Jun 24 17:12:40 test volumio[11076]: info: Exploding uri music-library/INTERNAL/1 Japanese in service mpd Jun 24 17:12:40 test volumio[11076]: info: Jun 24 17:12:40 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Kenio%20Fuke/Japanese%20Garden/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FAkatsuki%20-%20Kenio%20Fuke.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos/Japanese%20Traditional%20Koto%20And%20Shakuhachi%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FAki%20No%20Koto%20No%20Ha%20Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Aki No Koto No Ha Satomi Saeki And Alcvin Takegawa Ramos.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Will%20Savino/Music%20d20-%20Vol.%204/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FAko%20Will%20Savino.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Ako Will Savino.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos/Japanese%20Traditional%20Koto%20And%20Shakuhachi%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FChidori%20No%20Kyoku%20Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Chidori No Kyoku Satomi Saeki And Alcvin Takegawa Ramos.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/China%20and%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FDark%20Temple%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Dark Temple Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Japanese%20Zen%20Shakuhachi/Japanese%20Fantasy%20Music%20-%20Instrumental%20Traditional%20Sounds%20for%20Dream%2C%20Spa%2C%20Relaxation%2C%20Meditation%20(Koto%2C%20Flute%2C%20Drums)/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FDreaming%20to%20Fly%20Japanese%20Zen%20Shakuhachi.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Dreaming to Fly Japanese Zen Shakuhachi.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Liu%20Fang/Emerging%20Lotus%20-%20Chinese%20Traditional%20Guzheng%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FEmbroidering%20of%20the%20Golden%20Tapestry%20Liu%20Fang.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Embroidering of the Golden Tapestry Liu Fang.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Brandon%20Fiechter/Eastern%20Winds/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFalling%20Snow%20Brandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Falling Snow Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celestial%20Aeon%20Project%2CASKII/Far%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFar%20East%20Celestial%20Aeon%20Project%2CASKII.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Far East Celestial Aeon Project,ASKII.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Daniel%20May/Zen%20Garden/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFlower%20Daniel%20May.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Flower Daniel May.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Brandon%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFlute%20of%20Mysteries%20Brandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Flute of Mysteries Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/China%20and%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FForest%20of%20Japan%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Forest of Japan Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Brandon%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FForest%20of%20Sleep%20Brandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Forest of Sleep Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Yamato%20Ensemble/Yamato%20Ensemble-%20the%20Art%20of%20the%20Japanese%20Koto%2C%20Shakuhachi%20and%20Shamisen/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFutatsu%20No%20Den-En-Shi%20(2%20Pastorals)-%20No.%201.%20%E2%80%94%20Yamato%20Ensemble.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Futatsu No Den-En-Shi (2 Pastorals)- No. 1. — Yamato Ensemble.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos/Japanese%20Traditional%20Koto%20And%20Shakuhachi%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FFuyu%20Momiji%20-%20Satomi%20Saeki%20And%20Alcvin%20Takegawa%20Ramos.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Fuyu Momiji - Satomi Saeki And Alcvin Takegawa Ramos.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FGarden%20of%20Peace%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Garden of Peace Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celestial%20Aeon%20Project%2CASKII/Far%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FGeisha's%20Life%20Celestial%20Aeon%20Project%2CASKII.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Geisha's Life Celestial Aeon Project,ASKII.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FGlow%20of%20the%20Moon%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Glow of the Moon Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Nova%20Arcadia/Haiku%20in%20the%20Garden/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FHaiku%20in%20the%20Garden%20Nova%20Arcadia.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Haiku in the Garden Nova Arcadia.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FHealing%20Waters%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Healing Waters Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=S.Q.I.D./Ambient%20(Remastered%20Edition)/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FHeart%20of%20the%20Forest%20-%20Remastered%20Edition%20-%20S.Q.I.D..mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Heart of the Forest - Remastered Edition - S.Q.I.D..mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Liu%20Fang/Emerging%20Lotus%20-%20Chinese%20Traditional%20Guzheng%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FHigh%20Mountain%20and%20Flowing%20Water%20Liu%20Fang.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/High Mountain and Flowing Water Liu Fang.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/China%20and%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FJapanese%20Garden%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Japanese Garden Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/Eastern%20Winds/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FJapanese%20Lanterns%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Japanese Lanterns Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Japanese%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FJapanese%20Restaurant%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Japanese Restaurant Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Japanese%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FJapanese%20Spa%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Japanese Spa Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Healing%20Forest/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FKitsune%20Healer%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Kitsune Healer Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Duo%20En/Moonviewing/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FKojo%20no%20Tsuki%20(Moon%20Over%20Castle%20Ruins)%20Duo%20En.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Kojo no Tsuki (Moon Over Castle Ruins) Duo En.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Japanese%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FKoto%20Onsen%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Koto Onsen Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Richard%20Stagg/Shakuhachi-%20The%20Japanese%20Bamboo%20Flute/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FKumoi%20Jishi%20(Celestial%20Lion%20Dance)%20Richard%20Stagg.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Kumoi Jishi (Celestial Lion Dance) Richard Stagg.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Jiang%20Xiao-Qing/The%20Best%20of%20Japanese%20%26%20Chinese%20Meditation%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FLeaves%20of%20Autumn%20-%20Jiang%20Xiao-Qing.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Leaves of Autumn - Jiang Xiao-Qing.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Japanese%20Zen%20Shakuhachi/Exotic%20Spa%20%26%20Oriental%20Asian%20Music%20for%20Massage%20%E2%80%93%20Chinese%20%26%20Japanese%20Relaxing%20Sounds%2C%20Meditation%2C%20Regeneration%2C%20Enlightment%2C%20Zen%20Tracks/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FLotus%20Blossom%20Japanese%20Zen%20Shakuhachi.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Lotus Blossom Japanese Zen Shakuhachi.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Nova%20Arcadia/Tales%20of%20the%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FMists%20Nova%20Arcadia.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Mists Nova Arcadia.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Zen%20Music%20Garden%2CMassage%20Tribe%2CMassage%20Music/Zen%20Massage%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FMorning%20Fog%20Zen%20Music%20Garden%2CMassage%20Tribe%2CMassage%20Music.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Morning Fog Zen Music Garden,Massage Tribe,Massage Music.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Asian%20Flute%20Music%20Oasis/Kyoto%20Buddha%20Zen%20Garden-%20Traditional%20Japanese%20Flute%20Music%2C%20Peaceful%20Meditation%2C%20Feng%20Shui%2C%20Mystic%20Experience%2C%20Cherry%20Blossom%2C%20Oriental%20Yoga%20Space%20Relaxation/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FMysterious%20Stones%20(Classical%20Flute%20Music)%20Asian%20Flute%20Music%20Oasis.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Mysterious Stones (Classical Flute Music) Asian Flute Music Oasis.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Brandon%20Fiechter/China%20and%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FOrigami%20Master%20Brandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Origami Master Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Mizuyo%20Komiya/Lullaby/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FPath%20Mizuyo%20Komiya.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Path Mizuyo Komiya.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Kitsune/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FRiver%20Kitsune%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/River Kitsune Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Zumi-Kai/Koto%20Music%20Of%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FRokudan%20Zumi-Kai.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Rokudan Zumi-Kai.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Satomi%20Saeki/Japanese%20Koto%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSaika%20%E2%80%9CAccented%20Flower%E2%80%9D%20Satomi%20Saeki.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Saika “Accented Flower” Satomi Saeki.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/China%20and%20Japan/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSakura%20Blossoms%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Sakura Blossoms Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Hideo%20Osaka%20Ensemble/Traditional%20Music%20Of%20The%20Japanese%20Geisha/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSakura%20Hideo%20Osaka%20Ensemble.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Sakura Hideo Osaka Ensemble.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celestial%20Aeon%20Project%2CASKII/Far%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSamurai%20Poetry%20Celestial%20Aeon%20Project%2CASKII.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Samurai Poetry Celestial Aeon Project,ASKII.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Japanese%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FShakuhachi%20Sensei%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Shakuhachi Sensei Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Harmony%20Nature%20Sounds%20Academy/Japanese%20Zen%20Garden%20%E2%80%93%20Meditation%20Music%2C%20Zen%20Relaxation%20in%20Nature%2C%20New%20Age%20for%20Mindfulness%2C%20Rest%2C%20Yoga%2C%20Tai%20Chi%20and%20Spa%2C%20Ambience%20of%20Nature%2C%20Spiritual%20Therapy/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSoothing%20Bells%20in%20Nature%20Sanctuary%20Harmony%20Nature%20Sounds%20Academy.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Soothing Bells in Nature Sanctuary Harmony Nature Sounds Academy.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/World%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSoothing%20Spa%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Soothing Spa Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Japanese%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSushi%20Bar%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Sushi Bar Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter%2CBrandon%20Fiechter/Eastern%20Winds/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FSushi%20Restaurant%20Derek%20Fiechter%2CBrandon%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Sushi Restaurant Derek Fiechter,Brandon Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Alcvin%20Takegawa%20Ramos/Japanese%20Traditional%20Flute%20for%20Meditation-%20Zen%20Shakuhachi%20Vol%202/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FTakiotoshi%20(Sound%20of%20the%20Waterfall)%20Alcvin%20Takegawa%20Ramos.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Takiotoshi (Sound of the Waterfall) Alcvin Takegawa Ramos.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celia%20Briar/From%20The%20Mists%20Of%20Time/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FThe%20Clergys%20Lamentation%20-%20Celia%20Briar.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/The Clergys Lamentation - Celia Briar.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Nature%20Sounds/Forest%20-%20Sounds%20of%20Nature/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FThe%20Garden%20-%20Helios%20Relaxing%20Space%2C%20BigRicePiano.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/The Garden - Helios Relaxing Space, BigRicePiano.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celestial%20Aeon%20Project%2CASKII/Far%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FThe%20Royal%20Garden%20Celestial%20Aeon%20Project%2CASKII.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/The Royal Garden Celestial Aeon Project,ASKII.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/The%20Tea%20House/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FThe%20Tea%20House%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/The Tea House Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Japanese%20Zen%20Shakuhachi/Zen%20Shakuhachi-%20Secrets%20Garden%20With%20Japanese%20Traditional%20Flute%20Music%20for%20Asian%20Meditation%2C%20Thai%20Massage%20%26%20Spa/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FTraditional%20Musical%20Instruments%20of%20Japan%20Japanese%20Zen%20Shakuhachi.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Traditional Musical Instruments of Japan Japanese Zen Shakuhachi.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Yoshikazu%20Iwamoto/Traditional%20Japanese%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FTsuru%20No%20Sugomori%20Yoshikazu%20Iwamoto.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Tsuru No Sugomori Yoshikazu Iwamoto.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=UTTARA-KURU/Samurai%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FWings%20of%20the%20Eagle%20UTTARA-KURU.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Wings of the Eagle UTTARA-KURU.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Kitaro/Gaia%20-%20Onbashira/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FWood%20Fairy%20-%20Kitaro.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Wood Fairy - Kitaro.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Celestial%20Aeon%20Project%2CASKII/Far%20East/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FZen%20Celestial%20Aeon%20Project%2CASKII.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Zen Celestial Aeon Project,ASKII.mp3 Jun 24 17:12:40 test volumio[11076]: info: ALBUMART /albumart?cacheid=269&web=Derek%20Fiechter/Eastern%20Winds/extralarge&path=%2Fmnt%2FINTERNAL%2F1%20Japanese%2FZen%20Garden%20Derek%20Fiechter.mp3&metadata=false Jun 24 17:12:40 test volumio[11076]: info: URI /mnt/INTERNAL/1 Japanese/Zen Garden Derek Fiechter.mp3 Jun 24 17:12:40 test volumio[11076]: info: sendMpdCommand stop took 199 milliseconds Jun 24 17:12:40 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:40 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:40 test volumio[11076]: info: CoreCommandRouter::volumioPushQueue Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::saveQueue Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::updateTrackBlock Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrackBlock Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPlay Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::play index 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::stop Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::play index undefined Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::startPlaybackTimer Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3 Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 68 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand stop took 17 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 13 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 10 milliseconds Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand clear took 16 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3" Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":true,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Magia no Ar","artist":"Kenio Fuke","album":"Piano e Natureza, Vol. 5","uri":"INTERNAL/2 Nature Pinao/Magia no Ar.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService stop Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus stop Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: No code Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 24 17:12:41 test volumio[11076]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 268ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 87ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 84ms Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: error: updateQueue error: null Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 95ms Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand add "INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3" took 86 milliseconds Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 20ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 17ms Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand play Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces system playlist update Jun 24 17:12:41 test volumio[11076]: info: Ignoring MPD Status Update Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 43ms Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand play took 37 milliseconds Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 38ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 35ms Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 27 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 24 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 12 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 7 milliseconds Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: Jun 24 17:12:41 test volumio[11076]: ---------------------------- MPD announces state update: player Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 24 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 24 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 16 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand status took 10 milliseconds Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus stop Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:41 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:41 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:41 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 161ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 218ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 207ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 199ms Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 153 milliseconds Jun 24 17:12:41 test volumio[11076]: info: sendMpdCommand playlistinfo took 153 milliseconds Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:41 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:41 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:41 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:41 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:41 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 262ms Jun 24 17:12:41 test volumio[11076]: info: ------------------------------ 260ms Jun 24 17:12:47 test sshd[10947]: Received disconnect from 192.168.2.1 port 55446:11: disconnected by user Jun 24 17:12:47 test sshd[10947]: Disconnected from user root 192.168.2.1 port 55446 Jun 24 17:12:47 test sshd[10947]: pam_unix(sshd:session): session closed for user root Jun 24 17:12:47 test systemd[1]: session-27.scope: Succeeded. Jun 24 17:12:47 test systemd-logind[603]: Session 27 logged out. Waiting for processes to exit. Jun 24 17:12:47 test systemd-logind[603]: Removed session 27. Jun 24 17:12:47 test sshd[11641]: Accepted publickey for root from 192.168.2.1 port 55519 ssh2: RSA SHA256:+ZqEzlJXWcAGSfDzmm+baP9rZyx3J1wnRVkNditwAjI Jun 24 17:12:47 test sshd[11641]: pam_unix(sshd:session): session opened for user root by (uid=0) Jun 24 17:12:47 test systemd-logind[603]: New session 30 of user root. Jun 24 17:12:47 test systemd[1]: Started Session 30 of user root. Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: info: Jun 24 17:12:50 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:50 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: info: Jun 24 17:12:50 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:50 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: info: Jun 24 17:12:50 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:50 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 28 milliseconds Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 25 milliseconds Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 23 milliseconds Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 16 milliseconds Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 11 milliseconds Jun 24 17:12:50 test volumio[11076]: info: sendMpdCommand status took 8 milliseconds Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:50 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:50 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:50 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:51 test volumio[11076]: info: sendMpdCommand playlistinfo took 150 milliseconds Jun 24 17:12:51 test volumio[11076]: info: sendMpdCommand playlistinfo took 95 milliseconds Jun 24 17:12:51 test volumio[11076]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 24 17:12:51 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:51 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:51 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:51 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9859,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:51 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:51 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9859,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:51 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:51 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9859,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:51 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:51 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:51 test volumio[11076]: info: ------------------------------ 957ms Jun 24 17:12:51 test volumio[11076]: info: ------------------------------ 952ms Jun 24 17:12:51 test volumio[11076]: info: ------------------------------ 940ms Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioGetQueue Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::getQueue Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getQueue Jun 24 17:12:51 test volumio[11076]: info: CoreCommandRouter::volumioGetQueue Jun 24 17:12:51 test volumio[11076]: info: CoreStateMachine::getQueue Jun 24 17:12:51 test volumio[11076]: info: CorePlayQueue::getQueue Jun 24 17:12:53 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:53 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:53 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:53 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:53 test volumio[11076]: info: CoreCommandRouter::volumioGetState Jun 24 17:12:53 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: MPD Database updated - AlbumList cache refreshed Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: database Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: MPD Database updated - AlbumList cache refreshed Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: database Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: MPD Database updated - AlbumList cache refreshed Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: database Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 151 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 150 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 149 milliseconds Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 361 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 360 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 360 milliseconds Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 483 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 481 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 480 milliseconds Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: info: Command Router : Notfying DB Updatetrue Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 310 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 310 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 147 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 147 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13981,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":true,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:54 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:54 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:54 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 722ms Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 721ms Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 713ms Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 713ms Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 709ms Jun 24 17:12:54 test volumio[11076]: info: ------------------------------ 709ms Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 184 milliseconds Jun 24 17:12:54 test volumio[11076]: info: sendMpdCommand status took 179 milliseconds Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: info: Command Router : Notfying DB Updatefalse Jun 24 17:12:54 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:54 test volumio[11076]: info: Jun 24 17:12:54 test volumio[11076]: ---------------------------- MPD announces state update: update Jun 24 17:12:54 test volumio[11076]: info: ControllerMpd::getState Jun 24 17:12:54 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand status Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand playlistinfo took 112 milliseconds Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand status took 101 milliseconds Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand status took 87 milliseconds Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand status took 85 milliseconds Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand status took 82 milliseconds Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:55 test volumio[11076]: info: Command Router : Notfying DB Updatefalse Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:55 test volumio[11076]: info: Command Router : Notfying DB Updatefalse Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::Close All Modals sent Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseState Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 17:12:55 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14485,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:55 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:55 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: ------------------------------ 428ms Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand playlistinfo took 63 milliseconds Jun 24 17:12:55 test volumio[11076]: info: sendMpdCommand playlistinfo took 37 milliseconds Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:55 test volumio[11076]: verbose: ControllerMpd::parseTrackInfo Jun 24 17:12:55 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14737,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:55 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:55 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: ControllerMpd::pushState Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::servicePushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14737,"duration":302,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Akatsuki - Kenio Fuke","artist":"Kenio Fuke","album":"Japanese Garden","uri":"INTERNAL/1 Japanese/Akatsuki - Kenio Fuke.mp3","trackType":"mp3"} Jun 24 17:12:55 test volumio[11076]: verbose: CURRENT POSITION 0 Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState stateService play Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::syncState currentStatus play Jun 24 17:12:55 test volumio[11076]: info: Received an update from plugin. extracting info from payload Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: CoreStateMachine::pushState Jun 24 17:12:55 test volumio[11076]: info: CorePlayQueue::getTrack 0 Jun 24 17:12:55 test volumio[11076]: info: CoreCommandRouter::volumioPushState Jun 24 17:12:55 test volumio[11076]: info: ------------------------------ 269ms Jun 24 17:12:55 test volumio[11076]: info: ------------------------------ 253ms Jun 24 17:12:55 test volumio[11076]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 17:12:55 test volumio[11076]: Error [ERR_TLS_CERT_ALTNAME_INVALID]: Hostname/IP does not match certificate's altnames: Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me Jun 24 17:12:55 test volumio[11076]: at new NodeError (internal/errors.js:322:7) Jun 24 17:12:55 test volumio[11076]: at Object.checkServerIdentity (tls.js:347:12) Jun 24 17:12:55 test volumio[11076]: at TLSSocket.onConnectSecure (_tls_wrap.js:1525:27) Jun 24 17:12:55 test volumio[11076]: at TLSSocket.emit (events.js:400:28) Jun 24 17:12:55 test volumio[11076]: at TLSSocket._finishInit (_tls_wrap.js:937:8) Jun 24 17:12:55 test volumio[11076]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:709:12) { Jun 24 17:12:55 test volumio[11076]: reason: "Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me", Jun 24 17:12:55 test volumio[11076]: host: 'lastfm.freetls.fastly.net', Jun 24 17:12:55 test volumio[11076]: cert: { Jun 24 17:12:55 test volumio[11076]: subject: [Object: null prototype] { CN: 'retail.soundyoucanfeel.me' }, Jun 24 17:12:55 test volumio[11076]: issuer: [Object: null prototype] { C: 'US', O: "Let's Encrypt", CN: 'E6' }, Jun 24 17:12:55 test volumio[11076]: subjectaltname: 'DNS:retail.soundyoucanfeel.me', Jun 24 17:12:55 test volumio[11076]: infoAccess: [Object: null prototype] { Jun 24 17:12:55 test volumio[11076]: 'OCSP - URI': [Array], Jun 24 17:12:55 test volumio[11076]: 'CA Issuers - URI': [Array] Jun 24 17:12:55 test volumio[11076]: }, Jun 24 17:12:55 test volumio[11076]: bits: 384, Jun 24 17:12:55 test volumio[11076]: pubkey: , Jun 24 17:12:55 test volumio[11076]: asn1Curve: 'secp384r1', Jun 24 17:12:55 test volumio[11076]: nistCurve: 'P-384', Jun 24 17:12:55 test volumio[11076]: valid_from: 'Apr 28 03:36:45 2025 GMT', Jun 24 17:12:55 test volumio[11076]: valid_to: 'Jul 27 03:36:44 2025 GMT', Jun 24 17:12:55 test volumio[11076]: fingerprint: '2C:20:BE:9A:92:8E:B4:98:EB:F5:6A:8C:E4:D8:8C:F4:2F:F5:12:2C', Jun 24 17:12:55 test volumio[11076]: fingerprint256: '3B:B8:8D:75:E4:6D:1F:40:E8:92:34:C3:C6:B6:AC:BB:25:4B:C7:29:AD:F6:D0:D0:F4:F5:1E:1D:EE:11:9F:C0', Jun 24 17:12:55 test volumio[11076]: ext_key_usage: [ '1.3.6.1.5.5.7.3.1', '1.3.6.1.5.5.7.3.2' ], Jun 24 17:12:55 test volumio[11076]: serialNumber: '057C433BC5FCC264600F5E0C05A8F648F712', Jun 24 17:12:55 test volumio[11076]: raw: , Jun 24 17:12:55 test volumio[11076]: issuerCertificate: { Jun 24 17:12:55 test volumio[11076]: subject: [Object: null prototype], Jun 24 17:12:55 test volumio[11076]: issuer: [Object: null prototype], Jun 24 17:12:55 test volumio[11076]: infoAccess: [Object: null prototype], Jun 24 17:12:55 test volumio[11076]: bits: 384, Jun 24 17:12:55 test volumio[11076]: pubkey: , Jun 24 17:12:55 test volumio[11076]: asn1Curve: 'secp384r1', Jun 24 17:12:55 test volumio[11076]: nistCurve: 'P-384', Jun 24 17:12:55 test volumio[11076]: valid_from: 'Mar 13 00:00:00 2024 GMT', Jun 24 17:12:55 test volumio[11076]: valid_to: 'Mar 12 23:59:59 2027 GMT', Jun 24 17:12:55 test volumio[11076]: fingerprint: 'C9:4D:C4:83:1A:90:1A:9F:EC:0F:B4:9B:71:BD:49:B5:AA:D4:FA:D0', Jun 24 17:12:55 test volumio[11076]: fingerprint256: '76:E9:E2:88:AA:FC:0E:37:F4:39:0C:BF:94:6A:AD:99:7D:5C:1C:90:1B:3C:E5:13:D3:D8:FA:DB:AB:E2:AB:85', Jun 24 17:12:55 test volumio[11076]: ext_key_usage: [Array], Jun 24 17:12:55 test volumio[11076]: serialNumber: 'B0573E9173972770DBB487CB3A452B38', Jun 24 17:12:55 test volumio[11076]: raw: , Jun 24 17:12:55 test volumio[11076]: issuerCertificate: [Object] Jun 24 17:12:55 test volumio[11076]: } Jun 24 17:12:55 test volumio[11076]: }, Jun 24 17:12:55 test volumio[11076]: code: 'ERR_TLS_CERT_ALTNAME_INVALID' Jun 24 17:12:55 test volumio[11076]: } Jun 24 17:12:55 test volumio[11076]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 17:12:56 test sudo[12530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 17:11 Jun 24 17:12:56 test sudo[12530]: 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="eb7109a0318f43be1cdb19572cb80f7f163a915d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Чт 01 фев 2024 20:49:33 MSK" VOLUMIO_VERSION="3.0" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="22506d91c2deba7d4d5e58d82babad9f"