-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2024-07-21 14:43:34 CST. -- Jul 21 14:42:04 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 14:42:04 musicoffice volumio[4692]: info: CURURI: albums:// Jul 21 14:42:04 musicoffice volumio[4692]: info: listAlbums - loading Albums from cache Jul 21 14:42:04 musicoffice volumio[4692]: info: Preload queue cleared Jul 21 14:42:06 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 21 14:42:08 musicoffice volumio[4692]: info: Preload queue cleared Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::ClearQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::stPlaybackTimer Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::updateTrackBlock Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrackBlock Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::serviceStop Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::serviceStop Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::stop Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::clearPlayQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::saveQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::addQueueItems Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::addQueueItems Jul 21 14:42:08 musicoffice volumio[4692]: info: Preload queue cleared Jul 21 14:42:08 musicoffice volumio[4692]: info: Adding Item to queue: albums://Astrud%20Gilberto/Windy Jul 21 14:42:08 musicoffice volumio[4692]: info: Exploding uri albums://Astrud%20Gilberto/Windy in service mpd Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::saveQueue Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::updateTrackBlock Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrackBlock Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPlay Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::play index 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::play index undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::startPlaybackTimer Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::clearAddPlayTracks NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand stop took 97 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand stop took 55 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand clear Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 6 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand clear took 7 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 5 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 4 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand add "NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac" Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: No code Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus stop Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: No code Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 77ms Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 77ms Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: error: updateQueue error: null Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 85ms Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 81 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand add "NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac" took 82 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 6ms Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 5ms Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand play Jul 21 14:42:08 musicoffice volumio[4692]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 96ms Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces system playlist update Jul 21 14:42:08 musicoffice volumio[4692]: info: Ignoring MPD Status Update Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 22ms Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand play took 17 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 15ms Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 14ms Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 4 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 3 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 8 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 5 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 4 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus stop Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus play Jul 21 14:42:08 musicoffice volumio[4692]: info: Received an update from plugin. extracting info from payload Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 55ms Jul 21 14:42:08 musicoffice volumio[4692]: info: ------------------------------ 67ms Jul 21 14:42:08 musicoffice volumio[4692]: info: Jul 21 14:42:08 musicoffice volumio[4692]: ---------------------------- MPD announces state update: player Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::getState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand status Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 58 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 52 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: info: sendMpdCommand status took 2 milliseconds Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::parseState Jul 21 14:42:08 musicoffice volumio[4692]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus play Jul 21 14:42:08 musicoffice volumio[4692]: info: Received an update from plugin. extracting info from payload Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus play Jul 21 14:42:08 musicoffice volumio[4692]: info: Received an update from plugin. extracting info from payload Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:08 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus play Jul 21 14:42:08 musicoffice volumio[4692]: info: Received an update from plugin. extracting info from payload Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:08 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:08 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:09 musicoffice volumio[4692]: info: ------------------------------ 141ms Jul 21 14:42:09 musicoffice volumio[4692]: info: ------------------------------ 137ms Jul 21 14:42:09 musicoffice volumio[4692]: info: ------------------------------ 136ms Jul 21 14:42:09 musicoffice volumio[4692]: info: sendMpdCommand playlistinfo took 102 milliseconds Jul 21 14:42:09 musicoffice volumio[4692]: verbose: ControllerMpd::parseTrackInfo Jul 21 14:42:09 musicoffice volumio[4692]: info: ControllerMpd::pushState Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreCommandRouter::servicePushState Jul 21 14:42:09 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:09 musicoffice volumio[4692]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":125,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreamy","artist":"Astrud Gilberto","album":"Windy","uri":"NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac","trackType":"flac"} Jul 21 14:42:09 musicoffice volumio[4692]: verbose: CURRENT POSITION 0 Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreStateMachine::syncState stateService play Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreStateMachine::syncState currentStatus play Jul 21 14:42:09 musicoffice volumio[4692]: info: Received an update from plugin. extracting info from payload Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:09 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreStateMachine::pushState Jul 21 14:42:09 musicoffice volumio[4692]: info: CorePlayQueue::getTrack 0 Jul 21 14:42:09 musicoffice volumio[4692]: info: CoreCommandRouter::volumioPushState Jul 21 14:42:09 musicoffice volumio[4692]: info: ------------------------------ 131ms Jul 21 14:42:15 musicoffice nmbd[1548]: [2024/07/21 14:42:15.494685, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 21 14:42:15 musicoffice nmbd[1548]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.142 for name WORKGROUP<1d>. Jul 21 14:42:15 musicoffice nmbd[1548]: This response was from IP 192.168.1.11, reporting an IP address of 192.168.1.11. Jul 21 14:42:20 musicoffice volumio[4692]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 14:42:20 musicoffice volumio[4692]: info: CURURI: albums://Astrud%20Gilberto/Windy Jul 21 14:42:20 musicoffice volumio[4692]: info: Preload queue cleared Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/2. Chup Chup I Got Away.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/3. Never My Love.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/4. Lonely Afternoon.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/5. On My Mind.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/6. The Bare Necessities.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/7. Windy.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/8. Sing Me A Rainbow.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/9. In My Life.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/10. Crickets Sing For Anamaria (Os Grillos).flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Preloading song: music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/11. Where Are They Now-.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/2. Chup Chup I Got Away.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F1.%20Dreamy.flac&metadata=false Jul 21 14:42:20 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/1. Dreamy.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/3. Never My Love.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F2.%20Chup%20Chup%20I%20Got%20Away.flac&metadata=false Jul 21 14:42:20 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/2. Chup Chup I Got Away.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F3.%20Never%20My%20Love.flac&metadata=false Jul 21 14:42:20 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/3. Never My Love.flac Jul 21 14:42:20 musicoffice volumio[4692]: info: No valid Plugin REST Endpoint Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/4. Lonely Afternoon.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/5. On My Mind.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/6. The Bare Necessities.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/7. Windy.flac in service mpd Jul 21 14:42:20 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/8. Sing Me A Rainbow.flac in service mpd Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F4.%20Lonely%20Afternoon.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/4. Lonely Afternoon.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F5.%20On%20My%20Mind.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/5. On My Mind.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F6.%20The%20Bare%20Necessities.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/6. The Bare Necessities.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F7.%20Windy.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/7. Windy.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F8.%20Sing%20Me%20A%20Rainbow.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/8. Sing Me A Rainbow.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/9. In My Life.flac in service mpd Jul 21 14:42:21 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/10. Crickets Sing For Anamaria (Os Grillos).flac in service mpd Jul 21 14:42:21 musicoffice volumio[4692]: info: Exploding uri music-library/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/11. Where Are They Now-.flac in service mpd Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F9.%20In%20My%20Life.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/9. In My Life.flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F10.%20Crickets%20Sing%20For%20Anamaria%20(Os%20Grillos).flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/10. Crickets Sing For Anamaria (Os Grillos).flac Jul 21 14:42:21 musicoffice volumio[4692]: info: ALBUMART /albumart?cacheid=129&web=Astrud%20Gilberto/Windy/extralarge&path=%2Fmnt%2FNAS%2Fhomemusic%2F%E7%88%B5%E5%A3%AB%20Verve%20230%E5%BC%A0%2FAstrud%20Gilberto%20-%20Windy%2F11.%20Where%20Are%20They%20Now-.flac&metadata=false Jul 21 14:42:21 musicoffice volumio[4692]: info: URI /mnt/NAS/homemusic/爵士 Verve 230张/Astrud Gilberto - Windy/11. Where Are They Now-.flac Jul 21 14:43:33 musicoffice volumio[4692]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 14:43:33 musicoffice volumio[4692]: Error: connect ETIMEDOUT 199.16.158.9:80 Jul 21 14:43:33 musicoffice volumio[4692]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 21 14:43:33 musicoffice volumio[4692]: errno: -110, Jul 21 14:43:33 musicoffice volumio[4692]: code: 'ETIMEDOUT', Jul 21 14:43:33 musicoffice volumio[4692]: syscall: 'connect', Jul 21 14:43:33 musicoffice volumio[4692]: address: '199.16.158.9', Jul 21 14:43:33 musicoffice volumio[4692]: port: 80 Jul 21 14:43:33 musicoffice volumio[4692]: } Jul 21 14:43:33 musicoffice volumio[4692]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 14:43:34 musicoffice sudo[7326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 14:42 Jul 21 14:43:34 musicoffice sudo[7326]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"