-- Logs begin at Sun 2025-12-07 14:52:53 CET, end at Sun 2025-12-07 15:22:13 CET. -- Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Preload queue cleared Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::ClearQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::stop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::stPlaybackTimer Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::updateTrackBlock Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrackBlock Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::serviceStop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::serviceStop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: [1765117317628] ControllerWebradio::stop Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::clearPlayQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::saveQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::addQueueItems Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::addQueueItems Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Preload queue cleared Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Adding Item to queue: http://icecast.radiofrance.fr/francemusique-hifi.aac Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::saveQueue Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::updateTrackBlock Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrackBlock Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPlay Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::play index 0 Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::stop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::play index undefined Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CoreStateMachine::startPlaybackTimer Dec 07 15:21:57 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:21:57 volumio-l01 volumio[1028]: info: [1765117317631] ControllerWebradio::clearAddPlayTrack Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Dec 07 15:21:57 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:21:57 volumio-l01 volumio[1028]: info: sendMpdCommand stop took 10 milliseconds Dec 07 15:21:57 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:21:57 volumio-l01 volumio[1028]: info: sendMpdCommand stop took 7 milliseconds Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Dec 07 15:21:57 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:21:57 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:21:57 volumio-l01 volumio[1028]: info: sendMpdCommand status took 2 milliseconds Dec 07 15:21:57 volumio-l01 volumio[1028]: info: sendMpdCommand clear took 2 milliseconds Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:21:57 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/francemusique-hifi.aac" Dec 07 15:21:59 volumio-l01 volumio[1028]: error: updateQueue error: null Dec 07 15:21:59 volumio-l01 volumio[1028]: info: ------------------------------ 1770ms Dec 07 15:21:59 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 1770 milliseconds Dec 07 15:21:59 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/francemusique-hifi.aac" Dec 07 15:21:59 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:21:59 volumio-l01 volumio[1028]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 07 15:21:59 volumio-l01 volumio[1028]: info: ------------------------------ 1772ms Dec 07 15:21:59 volumio-l01 volumio[1028]: info: Dec 07 15:21:59 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:21:59 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:21:59 volumio-l01 volumio[1028]: info: sendMpdCommand add "http://icecast.radiofrance.fr/francemusique-hifi.aac" took 0 milliseconds Dec 07 15:21:59 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 15:21:59 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand play Dec 07 15:21:59 volumio-l01 volumio[1028]: info: ------------------------------ 1ms Dec 07 15:21:59 volumio-l01 volumio[1028]: info: sendMpdCommand play took 0 milliseconds Dec 07 15:22:00 volumio-l01 volumio[1028]: info: Dec 07 15:22:00 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:22:00 volumio-l01 volumio[1028]: info: Dec 07 15:22:00 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:22:00 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:22:00 volumio-l01 volumio[1028]: info: Dec 07 15:22:00 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:22:00 volumio-l01 volumio[1028]: info: sendMpdCommand status took 1 milliseconds Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ------------------------------ 1ms Dec 07 15:22:00 volumio-l01 volumio[1028]: info: sendMpdCommand status took 0 milliseconds Dec 07 15:22:00 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ControllerMpd::pushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::servicePushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"230 Kbps","isStreaming":false,"title":"francemusique-hifi.aac","artist":"francemusique-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/francemusique-hifi.aac","trackType":"aac"} Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: CURRENT POSITION 0 Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState stateService play Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ------------------------------ 2ms Dec 07 15:22:00 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ControllerMpd::pushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::servicePushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"230 Kbps","isStreaming":false,"title":"francemusique-hifi.aac","artist":"francemusique-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/francemusique-hifi.aac","trackType":"aac"} Dec 07 15:22:00 volumio-l01 volumio[1028]: verbose: CURRENT POSITION 0 Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState stateService play Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState currentStatus play Dec 07 15:22:00 volumio-l01 volumio[1028]: info: Received an update from plugin. extracting info from payload Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:22:00 volumio-l01 volumio[1028]: info: ------------------------------ 5ms Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Preload queue cleared Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::ClearQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::stop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::stPlaybackTimer Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::updateTrackBlock Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrackBlock Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::serviceStop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::serviceStop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: [1765117324464] ControllerWebradio::stop Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::clearPlayQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::saveQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::addQueueItems Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::addQueueItems Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Preload queue cleared Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Adding Item to queue: http://icecast.radiofrance.fr/franceculture-hifi.aac Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::saveQueue Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::updateTrackBlock Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrackBlock Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPlay Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::play index 0 Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::stop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::play index undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CoreStateMachine::startPlaybackTimer Dec 07 15:22:04 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:04 volumio-l01 volumio[1028]: info: [1765117324468] ControllerWebradio::clearAddPlayTrack Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand stop Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Dec 07 15:22:04 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:22:04 volumio-l01 volumio[1028]: info: sendMpdCommand stop took 10 milliseconds Dec 07 15:22:04 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:22:04 volumio-l01 volumio[1028]: info: sendMpdCommand stop took 6 milliseconds Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand clear Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Dec 07 15:22:04 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:22:04 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:22:04 volumio-l01 volumio[1028]: info: sendMpdCommand status took 1 milliseconds Dec 07 15:22:04 volumio-l01 volumio[1028]: info: sendMpdCommand clear took 0 milliseconds Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/franceculture-hifi.aac" Dec 07 15:22:04 volumio-l01 volumio[1028]: error: updateQueue error: null Dec 07 15:22:04 volumio-l01 volumio[1028]: info: ------------------------------ 0ms Dec 07 15:22:04 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 07 15:22:04 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:22:04 volumio-l01 volumio[1028]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 07 15:22:04 volumio-l01 volumio[1028]: info: ------------------------------ 1ms Dec 07 15:22:06 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/franceculture-hifi.aac" Dec 07 15:22:06 volumio-l01 volumio[1028]: info: Dec 07 15:22:06 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:22:06 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:22:06 volumio-l01 volumio[1028]: info: sendMpdCommand add "http://icecast.radiofrance.fr/franceculture-hifi.aac" took 1 milliseconds Dec 07 15:22:06 volumio-l01 volumio[1028]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 07 15:22:06 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand play Dec 07 15:22:06 volumio-l01 volumio[1028]: info: ------------------------------ 0ms Dec 07 15:22:06 volumio-l01 volumio[1028]: info: sendMpdCommand play took 0 milliseconds Dec 07 15:22:08 volumio-l01 volumio[1028]: info: Dec 07 15:22:08 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:22:08 volumio-l01 volumio[1028]: info: sendMpdCommand status took 1 milliseconds Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:22:08 volumio-l01 volumio[1028]: info: Dec 07 15:22:08 volumio-l01 volumio[1028]: ---------------------------- MPD announces system playlist update Dec 07 15:22:08 volumio-l01 volumio[1028]: info: Ignoring MPD Status Update Dec 07 15:22:08 volumio-l01 volumio[1028]: info: Dec 07 15:22:08 volumio-l01 volumio[1028]: ---------------------------- MPD announces state update: player Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ControllerMpd::getState Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:22:08 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ControllerMpd::pushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::servicePushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"230 Kbps","isStreaming":false,"title":"franceculture-hifi.aac","artist":"franceculture-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceculture-hifi.aac","trackType":"aac"} Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: CURRENT POSITION 0 Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState stateService play Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ------------------------------ 1ms Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ------------------------------ 1ms Dec 07 15:22:08 volumio-l01 volumio[1028]: info: sendMpdCommand status took 1 milliseconds Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseState Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 07 15:22:08 volumio-l01 volumio[1028]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: ControllerMpd::parseTrackInfo Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ControllerMpd::pushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::servicePushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"230 Kbps","isStreaming":false,"title":"franceculture-hifi.aac","artist":"franceculture-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceculture-hifi.aac","trackType":"aac"} Dec 07 15:22:08 volumio-l01 volumio[1028]: verbose: CURRENT POSITION 0 Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState stateService play Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::syncState currentStatus play Dec 07 15:22:08 volumio-l01 volumio[1028]: info: Received an update from plugin. extracting info from payload Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CorePlayQueue::getTrack 0 Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreStateMachine::pushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: CoreCommandRouter::volumioPushState Dec 07 15:22:08 volumio-l01 volumio[1028]: info: ------------------------------ 4ms Dec 07 15:22:13 volumio-l01 volumio[1028]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 15:22:13 volumio-l01 volumio[1028]: Error: connect ETIMEDOUT 92.122.166.165:443 Dec 07 15:22:13 volumio-l01 volumio[1028]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 07 15:22:13 volumio-l01 volumio[1028]: errno: -110, Dec 07 15:22:13 volumio-l01 volumio[1028]: code: 'ETIMEDOUT', Dec 07 15:22:13 volumio-l01 volumio[1028]: syscall: 'connect', Dec 07 15:22:13 volumio-l01 volumio[1028]: address: '92.122.166.165', Dec 07 15:22:13 volumio-l01 volumio[1028]: port: 443 Dec 07 15:22:13 volumio-l01 volumio[1028]: } Dec 07 15:22:13 volumio-l01 volumio[1028]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 15:22:13 volumio-l01 sudo[6052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 15:21 Dec 07 15:22:13 volumio-l01 sudo[6052]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"