-- Logs begin at Thu 2019-02-14 18:11:58 HKT, end at Tue 2025-06-03 22:21:48 HKT. -- Jun 03 22:20:01 volumio volumio[839]: info: Preload queue cleared Jun 03 22:20:01 volumio volumio[839]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::ClearQueue Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::stop Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::clearPlayQueue Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::saveQueue Jun 03 22:20:01 volumio volumio[839]: info: CoreCommandRouter::volumioPushQueue Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::addQueueItems Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::addQueueItems Jun 03 22:20:01 volumio volumio[839]: info: Preload queue cleared Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/01 Dance Into The Light.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/01 Dance Into The Light.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/02 That's What You Said.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/02 That's What You Said.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/03 Lorenzo.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/03 Lorenzo.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/04 Just Another Story.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/04 Just Another Story.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/05 Love Police.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/05 Love Police.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/06 Wear My Hat.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/06 Wear My Hat.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/07 It's In Your Eyes.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/07 It's In Your Eyes.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/08 Oughta Know By Now.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/08 Oughta Know By Now.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a Jun 03 22:20:01 volumio volumio[839]: info: CoreCommandRouter::volumioPushQueue Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::saveQueue Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::updateTrackBlock Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::getTrackBlock Jun 03 22:20:01 volumio volumio[839]: info: CoreCommandRouter::volumioPlay Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::play index 8 Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::addQueueItems Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::addQueueItems Jun 03 22:20:01 volumio volumio[839]: info: Preload queue cleared Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/10 The Same Moon.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/10 The Same Moon.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/11 River So Wide.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/11 River So Wide.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/12 No Matter Who.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/12 No Matter Who.m4a Jun 03 22:20:01 volumio volumio[839]: info: Adding Item to queue: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/13 The Times They Are A-changin'.m4a Jun 03 22:20:01 volumio volumio[839]: info: Using cached record of: music-library/NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/13 The Times They Are A-changin'.m4a Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::stop Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 22:20:01 volumio volumio[839]: info: CoreCommandRouter::volumioPushQueue Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::saveQueue Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::play index undefined Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::updateTrackBlock Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::getTrackBlock Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:01 volumio volumio[839]: info: CoreStateMachine::startPlaybackTimer Jun 03 22:20:01 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:01 volumio volumio[839]: verbose: ControllerMpd::clearAddPlayTracks NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a Jun 03 22:20:01 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 22:20:01 volumio volumio[839]: info: sendMpdCommand stop took 3 milliseconds Jun 03 22:20:01 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand clear Jun 03 22:20:01 volumio volumio[839]: info: sendMpdCommand clear took 1 milliseconds Jun 03 22:20:01 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand add "NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a" Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: info: sendMpdCommand add "NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a" took 2 milliseconds Jun 03 22:20:01 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand play Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 6ms Jun 03 22:20:01 volumio volumio[839]: info: sendMpdCommand play took 5 milliseconds Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 4ms Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 3ms Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: info: Jun 03 22:20:01 volumio volumio[839]: ---------------------------- MPD announces system playlist update Jun 03 22:20:01 volumio volumio[839]: info: Ignoring MPD Status Update Jun 03 22:20:01 volumio volumio[839]: error: Upnp client error: Error: This socket has been ended by the other party Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 5ms Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 3ms Jun 03 22:20:01 volumio volumio[839]: info: ------------------------------ 2ms Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 21 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 21 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 20 milliseconds Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 5 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus stop Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus play Jun 03 22:20:02 volumio volumio[839]: info: Received an update from plugin. extracting info from payload Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus play Jun 03 22:20:02 volumio volumio[839]: info: Received an update from plugin. extracting info from payload Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 48ms Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 59ms Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 58ms Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: Jun 03 22:20:02 volumio volumio[839]: ---------------------------- MPD announces state update: player Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::getState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 35 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 4 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand status took 3 milliseconds Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseState Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus play Jun 03 22:20:02 volumio volumio[839]: info: Received an update from plugin. extracting info from payload Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 60ms Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 27 milliseconds Jun 03 22:20:02 volumio volumio[839]: info: sendMpdCommand playlistinfo took 27 milliseconds Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus play Jun 03 22:20:02 volumio volumio[839]: info: Received an update from plugin. extracting info from payload Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: ControllerMpd::pushState Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::servicePushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Take Me Down","artist":"Phil Collins","album":"Dance into the Light_ALAC","uri":"NAS/Multimedia/Phil Collins/Dance into the Light_ALAC/09 Take Me Down.m4a","trackType":"m4a"} Jun 03 22:20:02 volumio volumio[839]: verbose: CURRENT POSITION 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState stateService play Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus play Jun 03 22:20:02 volumio volumio[839]: info: Received an update from plugin. extracting info from payload Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: CoreStateMachine::pushState Jun 03 22:20:02 volumio volumio[839]: info: CorePlayQueue::getTrack 8 Jun 03 22:20:02 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 58ms Jun 03 22:20:02 volumio volumio[839]: info: ------------------------------ 56ms Jun 03 22:21:47 volumio volumio[839]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 22:21:47 volumio volumio[839]: Error: connect ETIMEDOUT 179.60.193.9:443 Jun 03 22:21:47 volumio volumio[839]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 03 22:21:47 volumio volumio[839]: errno: -110, Jun 03 22:21:47 volumio volumio[839]: code: 'ETIMEDOUT', Jun 03 22:21:47 volumio volumio[839]: syscall: 'connect', Jun 03 22:21:47 volumio volumio[839]: address: '179.60.193.9', Jun 03 22:21:47 volumio volumio[839]: port: 443 Jun 03 22:21:47 volumio volumio[839]: } Jun 03 22:21:47 volumio volumio[839]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 22:21:48 volumio sudo[4999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-03 22:20 Jun 03 22:21:48 volumio sudo[4999]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:53:51 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="53825f995260683aee752aed6b29f24e"