-- Logs begin at Fri 2020-12-11 14:53:56 UTC, end at Wed 2025-07-02 14:39:33 UTC. -- Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:07 volumion1 volumio[8143]: info: Jul 02 14:38:07 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:07 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:07 volumion1 volumio[8143]: info: Jul 02 14:38:07 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:07 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:07 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:07 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:07 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25855,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:07 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService play Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus play Jul 02 14:38:07 volumion1 volumio[8143]: info: Received an update from plugin. extracting info from payload Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:07 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25855,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:07 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService play Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus play Jul 02 14:38:07 volumion1 volumio[8143]: info: Received an update from plugin. extracting info from payload Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:07 volumion1 volumio[8143]: info: ------------------------------ 104ms Jul 02 14:38:07 volumion1 volumio[8143]: info: ------------------------------ 102ms Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPause Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::pause Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::servicePause Jul 02 14:38:11 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreCommandRouter::servicePause Jul 02 14:38:11 volumion1 volumio[8143]: info: ControllerMpd::pause Jul 02 14:38:11 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand pause Jul 02 14:38:11 volumion1 volumio[8143]: info: Jul 02 14:38:11 volumion1 volumio[8143]: ---------------------------- MPD announces state update: player Jul 02 14:38:11 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:11 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:11 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:11 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:11 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:11 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:11 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:11 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:11 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:11 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:11 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:11 volumion1 volumio[8143]: info: ------------------------------ 15ms Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreCommandRouter::volumioRandom Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreCommandRouter::writePlayerControls Jul 02 14:38:13 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreStateMachine::setRandom true Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:13 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:13 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreCommandRouter::volumioRandom Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreCommandRouter::writePlayerControls Jul 02 14:38:14 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreStateMachine::setRandom false Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:14 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:14 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:19 volumion1 volumio[8143]: info: Jul 02 14:38:19 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:19 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:19 volumion1 volumio[8143]: info: Jul 02 14:38:19 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:19 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:19 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:19 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:19 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:19 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:19 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:19 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:19 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:19 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:19 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:19 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:19 volumion1 volumio[8143]: info: ------------------------------ 82ms Jul 02 14:38:19 volumion1 volumio[8143]: info: ------------------------------ 78ms Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:38 volumion1 volumio[8143]: info: Jul 02 14:38:38 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:38 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:38 volumion1 volumio[8143]: info: Jul 02 14:38:38 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:38 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:38 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatetrue Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:38 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:38 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:38 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:38 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:38 volumion1 volumio[8143]: info: ------------------------------ 81ms Jul 02 14:38:38 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:38 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:38 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:38 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:38 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:38 volumion1 volumio[8143]: info: ------------------------------ 94ms Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:58 volumion1 volumio[8143]: info: Jul 02 14:38:58 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:58 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:58 volumion1 volumio[8143]: info: Jul 02 14:38:58 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:38:58 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:58 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatetrue Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:58 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:58 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:58 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:58 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:58 volumion1 volumio[8143]: info: ------------------------------ 70ms Jul 02 14:38:58 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:38:58 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:58 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:38:58 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:38:58 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:38:58 volumion1 volumio[8143]: info: ------------------------------ 83ms Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:39:07 volumion1 volumio[8143]: info: Jul 02 14:39:07 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:39:07 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:39:07 volumion1 volumio[8143]: info: Jul 02 14:39:07 volumion1 volumio[8143]: ---------------------------- MPD announces state update: update Jul 02 14:39:07 volumion1 volumio[8143]: info: ControllerMpd::getState Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:39:07 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:39:07 volumion1 volumio[8143]: info: Command Router : Notfying DB Updatefalse Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseState Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:39:07 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:07 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:39:07 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:39:07 volumion1 volumio[8143]: info: ------------------------------ 70ms Jul 02 14:39:07 volumion1 volumio[8143]: verbose: ControllerMpd::parseTrackInfo Jul 02 14:39:07 volumion1 volumio[8143]: info: ControllerMpd::pushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::servicePushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:07 volumion1 volumio[8143]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":30104,"duration":196,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Change","artist":"Laura Fygi","album":"Change","uri":"USB/MUSIC/03 - Change.mp3","trackType":"mp3"} Jul 02 14:39:07 volumion1 volumio[8143]: verbose: CURRENT POSITION 0 Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState stateService pause Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::syncState currentStatus pause Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::pushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:07 volumion1 volumio[8143]: info: CoreStateMachine::stPlaybackTimer Jul 02 14:39:07 volumion1 volumio[8143]: info: ------------------------------ 82ms Jul 02 14:39:07 volumion1 volumio[8143]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aimee%20Allen/A%20Little%20Happiness/18a09bd1-52cb-4ef9-be96-f0582b8ddf4f.jpg' Jul 02 14:39:07 volumion1 volumio[8143]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Tamas%20Wells/A%20Plea%20en%20Vendredi/1c9c7905-f054-4c22-806c-3ea3b0b513ed.jpg' Jul 02 14:39:08 volumion1 volumio[8143]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%86%AF%E6%9B%A6%E5%A6%A4/A%20Little%20Love/b1df186e-2d5a-45bb-95ff-4bfd3f24f591.jpg' Jul 02 14:39:15 volumion1 volumio[8143]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 14:39:15 volumion1 volumio[8143]: { Error: connect ETIMEDOUT 31.13.84.34:443 Jul 02 14:39:15 volumion1 volumio[8143]: at Object._errnoException (util.js:1022:11) Jul 02 14:39:15 volumion1 volumio[8143]: at _exceptionWithHostPort (util.js:1044:20) Jul 02 14:39:15 volumion1 volumio[8143]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 02 14:39:15 volumion1 volumio[8143]: code: 'ETIMEDOUT', Jul 02 14:39:15 volumion1 volumio[8143]: errno: 'ETIMEDOUT', Jul 02 14:39:15 volumion1 volumio[8143]: syscall: 'connect', Jul 02 14:39:15 volumion1 volumio[8143]: address: '31.13.84.34', Jul 02 14:39:15 volumion1 volumio[8143]: port: 443 } Jul 02 14:39:15 volumion1 volumio[8143]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 14:39:16 volumion1 sudo[15483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-02 14:38 Jul 02 14:39:16 volumion1 sudo[15483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:16 volumion1 sudo[15483]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:18 volumion1 volumio-remote-updater[4548]: [2025-07-02 14:39:18] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 02 14:39:18 volumion1 volumio-remote-updater[4548]: [2025-07-02 14:39:18] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 02 14:39:18 volumion1 systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jul 02 14:39:18 volumion1 systemd[1]: Unit volumio.service entered failed state. Jul 02 14:39:18 volumion1 systemd[1]: Starting dynamicswap service... Jul 02 14:39:18 volumion1 systemd[1]: Started dynamicswap service. Jul 02 14:39:18 volumion1 systemd[1]: volumio.service holdoff time over, scheduling restart. Jul 02 14:39:18 volumion1 systemd[1]: Starting dynamicswap service... Jul 02 14:39:18 volumion1 systemd[1]: Started dynamicswap service. Jul 02 14:39:18 volumion1 systemd[1]: Stopping Volumio Backend Module... Jul 02 14:39:18 volumion1 systemd[1]: Starting Volumio Backend Module... Jul 02 14:39:18 volumion1 systemd[1]: Started Volumio Backend Module. Jul 02 14:39:20 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:20 volumion1 volumio[15513]: info: ----- Volumio2 ---- Jul 02 14:39:20 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:20 volumion1 volumio[15513]: info: ----- System startup ---- Jul 02 14:39:20 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:21 volumion1 volumio[15513]: info: MYVOLUMIO Environment detected Jul 02 14:39:21 volumion1 volumio[15513]: info: Plugin folders cleanup Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning into folder /volumio/app/plugins/ Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category audio_interface Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category miscellanea Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category music_service Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category plugins.json Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category system_controller Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning category user_interface Jul 02 14:39:21 volumion1 volumio[15513]: info: Scanning into folder /data/plugins/ Jul 02 14:39:21 volumion1 volumio[15513]: info: Plugin folders cleanup completed Jul 02 14:39:21 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:21 volumion1 volumio[15513]: info: ----- Core plugins startup ---- Jul 02 14:39:21 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:21 volumion1 volumio[15513]: info: Loading plugins from folder /volumio/app/plugins/ Jul 02 14:39:21 volumion1 volumio[15513]: info: Adding plugin upnp to MyMusic Plugins Jul 02 14:39:21 volumion1 volumio[15513]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 02 14:39:21 volumion1 volumio[15513]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 02 14:39:21 volumion1 volumio[15513]: info: Loading plugins from folder /data/plugins/ Jul 02 14:39:21 volumion1 volumio[15513]: info: Loading plugin "system"... Jul 02 14:39:21 volumion1 volumio[15513]: info: Loading plugin "appearance"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "network"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Refreshing Cached IP Addresses Jul 02 14:39:22 volumion1 sudo[15542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 02 14:39:22 volumion1 sudo[15542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:22 volumion1 sudo[15542]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "services"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "alsa_controller"... Jul 02 14:39:22 volumion1 sudo[15545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 02 14:39:22 volumion1 sudo[15545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:22 volumion1 sudo[15545]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "wizard"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "volumio_command_line_client"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "upnp"... Jul 02 14:39:22 volumion1 volumio[15513]: info: [1751467162572] Starting Upmpd Daemon Jul 02 14:39:22 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "my_music"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "mpd"... Jul 02 14:39:22 volumion1 volumio[15513]: info: Loading plugin "upnp_browser"... Jul 02 14:39:23 volumion1 volumio-remote-updater[4548]: [2025-07-02 14:39:23] [connect] Successful connection Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "networkfs"... Jul 02 14:39:23 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "alarm-clock"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "airplay_emulation"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Starting Shairport Sync Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "last_100"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "webradio"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "i2s_dacs"... Jul 02 14:39:23 volumion1 volumio[15513]: info: I2S DAC not set, start Auto-detection Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "volumiodiscovery"... Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** For more information see Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 14:39:23 volumion1 node[15513]: *** WARNING *** For more information see Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** For more information see Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 14:39:23 volumion1 volumio[15513]: *** WARNING *** For more information see Jul 02 14:39:23 volumion1 volumio[15513]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 02 14:39:23 volumion1 volumio[15513]: Discovery: StartAdv! undefined Jul 02 14:39:23 volumion1 volumio[15513]: Discovery: Started advertising... Volumio - undefined Jul 02 14:39:23 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "outputs"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "albumart"... Jul 02 14:39:23 volumion1 volumio[15513]: info: Plugin example_plugin is not enabled Jul 02 14:39:23 volumion1 volumio[15513]: info: Loading plugin "inputs"... Jul 02 14:39:24 volumion1 volumio[15513]: info: Loading plugin "updater_comm"... Jul 02 14:39:24 volumion1 volumio[15513]: info: Plugin mpdemulation is not enabled Jul 02 14:39:24 volumion1 volumio[15513]: info: Loading plugin "rest_api"... Jul 02 14:39:24 volumion1 volumio[15513]: info: Loading plugin "websocket"... Jul 02 14:39:24 volumion1 volumio[15513]: info: ___________ START PLUGINS ___________ Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 14:39:24 volumion1 volumio[15513]: info: [1751467164250] CoreMusicLibrary::Adding element Media Servers Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 14:39:24 volumion1 volumio[15513]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 02 14:39:24 volumion1 volumio[15513]: Forking 3 albumart workers Jul 02 14:39:24 volumion1 volumio[15513]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 14:39:24 volumion1 volumio[15513]: info: [1751467164369] CoreMusicLibrary::Adding element Last_100 Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 14:39:24 volumion1 volumio[15513]: info: [1751467164374] CoreMusicLibrary::Adding element Webradio Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 14:39:24 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:24 volumion1 volumio[15513]: info: ----- MyVolumio plugins startup ---- Jul 02 14:39:24 volumion1 volumio[15513]: info: ------------------------------------------- Jul 02 14:39:24 volumion1 volumio[15513]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 02 14:39:24 volumion1 volumio[15513]: info: Loading i18n strings for locale zh Jul 02 14:39:24 volumion1 volumio[15513]: Updating browse sources language Jul 02 14:39:24 volumion1 volumio[15513]: Cannot find translation for sourceMedia Servers Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::initPlayerControls Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 14:39:24 volumion1 volumio[15513]: info: BOOT COMPLETED Jul 02 14:39:24 volumion1 volumio[15513]: [Metrics] CommandRouter: 4s 261.88ms Jul 02 14:39:24 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 14:39:25 volumion1 volumio[15513]: Starting albumart workers Jul 02 14:39:25 volumion1 volumio[15513]: Starting albumart workers Jul 02 14:39:25 volumion1 volumio[15513]: Starting albumart workers Jul 02 14:39:29 volumion1 volumio[15513]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 02 14:39:29 volumion1 volumio[15513]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:39:29 volumion1 volumio[15513]: info: CoreCommandRouter::Close All Modals sent Jul 02 14:39:29 volumion1 volumio[15513]: Express server listening on port 3000 Jul 02 14:39:29 volumion1 volumio[15513]: [Metrics] WebUI: 10s 115.10ms Jul 02 14:39:29 volumion1 volumio[15513]: Volumio Calling Home Jul 02 14:39:29 volumion1 volumio[15513]: info: CoreStateMachine::resetVolumioState Jul 02 14:39:29 volumion1 volumio[15513]: info: CoreStateMachine::getcurrentVolume Jul 02 14:39:29 volumion1 volumio[15513]: info: CoreCommandRouter::volumioRetrievevolume Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 14:39:30 volumion1 volumio[15513]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 02 14:39:30 volumion1 volumio[15513]: info: Setting Device type: Amlogic Jul 02 14:39:30 volumion1 volumio[15513]: info: MPD running with PID7331 Jul 02 14:39:30 volumion1 volumio[15513]: ,establishing connection Jul 02 14:39:30 volumion1 sudo[15646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jul 02 14:39:30 volumion1 sudo[15646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:30 volumion1 sudo[15646]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:30 volumion1 volumio[15513]: info: VolumeController:: Volume=44 Mute =false Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::updateTrackBlock Jul 02 14:39:30 volumion1 volumio[15513]: info: CorePlayQueue::getTrackBlock Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::volumioRetrievevolume Jul 02 14:39:30 volumion1 volumio[15513]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jul 02 14:39:30 volumion1 volumio[15513]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Jul 02 14:39:30 volumion1 volumio[15513]: info: Reloading queue from file Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::setRepeat null single undefined Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::setRandom false Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 02 14:39:30 volumion1 volumio[15513]: info: VolumeController:: Volume=44 Mute =false Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:30 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:30 volumion1 volumio[15513]: info: Starting Shairport Sync Jul 02 14:39:30 volumion1 volumio[15513]: info: Starting Shairport Sync Jul 02 14:39:31 volumion1 sudo[15658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 02 14:39:31 volumion1 sudo[15658]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:31 volumion1 sudo[15660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 02 14:39:31 volumion1 sudo[15660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 14:39:31 volumion1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 02 14:39:31 volumion1 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 02 14:39:31 volumion1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 02 14:39:31 volumion1 sudo[15658]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:31 volumion1 sudo[15660]: pam_unix(sudo:session): session closed for user root Jul 02 14:39:31 volumion1 volumio[15513]: Discovery: adding 1746ddf5-e3fe-4ae8-9fb9-e16fcc5d2989 Jul 02 14:39:31 volumion1 volumio[15513]: info: mDNS: Found device Volumio Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioGetState Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:31 volumion1 volumio[15513]: info: Shairport-Sync Started Jul 02 14:39:31 volumion1 volumio[15513]: Error adding Membership: Error: addMembership EINVAL Jul 02 14:39:31 volumion1 volumio[15513]: info: Shairport-Sync Started Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioGetState Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:31 volumion1 volumio[15513]: info: Clearing queue after UPNP request Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::ClearQueue Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::stop Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 14:39:31 volumion1 volumio[15513]: UNSET VOLATILE Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::clearPlayQueue Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::saveQueue Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushQueue Jul 02 14:39:31 volumion1 volumio[15513]: info: Jul 02 14:39:31 volumion1 volumio[15513]: ---------------------------- MPD announces system playlist update Jul 02 14:39:31 volumion1 volumio[15513]: info: Ignoring MPD Status Update Jul 02 14:39:31 volumion1 volumio[15513]: info: Jul 02 14:39:31 volumion1 volumio[15513]: ---------------------------- MPD announces state update: player Jul 02 14:39:31 volumion1 volumio[15513]: info: ControllerMpd::getState Jul 02 14:39:31 volumion1 volumio[15513]: verbose: ControllerMpd::sendMpdCommand status Jul 02 14:39:31 volumion1 volumio[15513]: info: Starting UPNP Playback Jul 02 14:39:31 volumion1 volumio[15513]: info: Preparing playback through UPNP Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioGetState Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 02 14:39:31 volumion1 volumio[15513]: error: updateQueue error: null Jul 02 14:39:31 volumion1 volumio[15513]: info: ------------------------------ 16ms Jul 02 14:39:31 volumion1 volumio[15513]: verbose: ControllerMpd::parseState Jul 02 14:39:31 volumion1 volumio[15513]: info: ControllerMpd::pushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::servicePushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:31 volumion1 volumio[15513]: info: CorePlayQueue::getTrack 0 Jul 02 14:39:31 volumion1 volumio[15513]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 02 14:39:31 volumion1 volumio[15513]: verbose: CURRENT POSITION 0 Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::syncState stateService stop Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::syncState currentStatus stop Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:31 volumion1 volumio[15513]: info: No code Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreStateMachine::pushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::volumioPushState Jul 02 14:39:31 volumion1 volumio[15513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 14:39:31 volumion1 volumio[15513]: info: ------------------------------ 46ms Jul 02 14:39:32 volumion1 volumio[15513]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 14:39:32 volumion1 volumio[15513]: { Error: connect ECONNREFUSED 4.78.139.54:443 Jul 02 14:39:32 volumion1 volumio[15513]: at Object._errnoException (util.js:1022:11) Jul 02 14:39:32 volumion1 volumio[15513]: at _exceptionWithHostPort (util.js:1044:20) Jul 02 14:39:32 volumion1 volumio[15513]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 02 14:39:32 volumion1 volumio[15513]: code: 'ECONNREFUSED', Jul 02 14:39:32 volumion1 volumio[15513]: errno: 'ECONNREFUSED', Jul 02 14:39:32 volumion1 volumio[15513]: syscall: 'connect', Jul 02 14:39:32 volumion1 volumio[15513]: address: '4.78.139.54', Jul 02 14:39:32 volumion1 volumio[15513]: port: 443 } Jul 02 14:39:32 volumion1 volumio[15513]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 14:39:33 volumion1 sudo[15689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-02 14:38 Jul 02 14:39:33 volumion1 sudo[15689]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"