Dec 19 13:49:00 volumio volumio[1462]: info: CoreCommandRouter::servicePushState Dec 19 13:49:00 volumio volumio[1462]: info: CoreStateMachine::pushState Dec 19 13:49:00 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:49:00 volumio volumio[1462]: info: CoreCommandRouter::volumioPushState Dec 19 13:49:00 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:49:10 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 67. Dec 19 13:49:10 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:10 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:10 volumio upmpdcli[4242]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:49:10 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:49:10 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:49:12 volumio volumio[1462]: info: CoreCommandRouter::volumioGetQueue Dec 19 13:49:12 volumio volumio[1462]: info: CoreStateMachine::getQueue Dec 19 13:49:12 volumio volumio[1462]: info: CorePlayQueue::getQueue Dec 19 13:49:15 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 19 13:49:15 volumio volumio[1462]: info: CURURI: music-library/USB/D46E07D16E07AAF6/Teszt Dec 19 13:49:16 volumio volumio[1462]: info: Preload queue cleared Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Nothing To Hide (Mixed).flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Keith Don't Go (Live).flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Poem Of Chinese Drum.flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Toccata & Fugue In D Minor, BWV 565.flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Colour to the Moon.flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Whiskey In The Jar.flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/Hotel California (Live On MTV, 1994).flac Dec 19 13:49:16 volumio volumio[1462]: info: Preloading song: music-library/USB/D46E07D16E07AAF6/Teszt/You And Your Friend.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Nothing To Hide (Mixed).flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Cosmic%20Gate%2C%20Diana%20Miro/A%20State%20Of%20Trance%20Year%20Mix%202021%20(Mixed%20by%20Armin%20van%20Buuren)/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FNothing%20To%20Hide%20(Mixed).flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Nothing To Hide (Mixed).flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Keith Don't Go (Live).flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Nils%20Lofgren/Acoustic%20Live/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FKeith%20Don't%20Go%20(Live).flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Keith Don't Go (Live).flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Candy%20Dulfer/Candy%20Dulfer%20Live%20In%20Amsterdam/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FLily%20Was%20Here.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Poem Of Chinese Drum.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Hok-man%20Yim/China%20Hok-Man%20Yim%3A%20Poems%20of%20Thunder%20-%20Percussion/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FPoem%20Of%20Chinese%20Drum.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Poem Of Chinese Drum.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Toccata & Fugue In D Minor, BWV 565.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Bach%2C%20Klemens%20Schnorr/Classical%20Music%20for%20Halloween%3A%2013%20Spooky%2C%20Scary%2C%20Dark%20and%20Creepy%20Songs%20to%20Scare%20Trick-Or-Treaters/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FToccata%20%26%20Fugue%20In%20D%20Minor%2C%20BWV%20565.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Toccata & Fugue In D Minor, BWV 565.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Colour to the Moon.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Allan%20Taylor/Colour%20to%20the%20Moon/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FColour%20to%20the%20Moon.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Colour to the Moon.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Whiskey In The Jar.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Metallica/Garage%20Inc./extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FWhiskey%20In%20The%20Jar.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Whiskey In The Jar.flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/Hotel California (Live On MTV, 1994).flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Eagles/Hell%20Freezes%20Over%20(Remaster%202018)/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FHotel%20California%20(Live%20On%20MTV%2C%201994).flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/Hotel California (Live On MTV, 1994).flac Dec 19 13:49:16 volumio volumio[1462]: info: Exploding uri music-library/USB/D46E07D16E07AAF6/Teszt/You And Your Friend.flac in service mpd Dec 19 13:49:16 volumio volumio[1462]: info: ALBUMART /albumart?cacheid=449&web=Dire%20Straits/On%20Every%20Street/extralarge&path=%2Fmnt%2FUSB%2FD46E07D16E07AAF6%2FTeszt%2FYou%20And%20Your%20Friend.flac&metadata=false Dec 19 13:49:16 volumio volumio[1462]: info: URI /mnt/USB/D46E07D16E07AAF6/Teszt/You And Your Friend.flac Dec 19 13:49:17 volumio volumio[1462]: info: Preload queue cleared Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::ClearQueue Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::stop Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::serviceStop Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::serviceStop Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::clearPlayQueue Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::saveQueue Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioPushQueue Dec 19 13:49:17 volumio vtcs[2315]: [close:85] Entering Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::addQueueItems Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::addQueueItems Dec 19 13:49:17 volumio volumio[1462]: info: Preload queue cleared Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Nothing To Hide (Mixed).flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Nothing To Hide (Mixed).flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Keith Don't Go (Live).flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Keith Don't Go (Live).flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioPushQueue Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::saveQueue Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::updateTrackBlock Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::getTrackBlock Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioPlay Dec 19 13:49:17 volumio volumio[1462]: verbose: UNSET VOLATILE: Service: tidalconnect Dec 19 13:49:17 volumio volumio[1462]: info: unSetVolatile called Dec 19 13:49:17 volumio volumio[1462]: info: Relinquishing Volumio State to another service Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::play index 2 Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::addQueueItems Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::addQueueItems Dec 19 13:49:17 volumio volumio[1462]: info: Preload queue cleared Dec 19 13:49:17 volumio vtcs[2315]: [2025-12-19 13:49:17.992] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Poem Of Chinese Drum.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Poem Of Chinese Drum.flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Toccata & Fugue In D Minor, BWV 565.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Toccata & Fugue In D Minor, BWV 565.flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Colour to the Moon.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Colour to the Moon.flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Whiskey In The Jar.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Whiskey In The Jar.flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/Hotel California (Live On MTV, 1994).flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/Hotel California (Live On MTV, 1994).flac Dec 19 13:49:17 volumio volumio[1462]: info: Adding Item to queue: music-library/USB/D46E07D16E07AAF6/Teszt/You And Your Friend.flac Dec 19 13:49:17 volumio volumio[1462]: info: Using cached record of: music-library/USB/D46E07D16E07AAF6/Teszt/You And Your Friend.flac Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::stop Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::stPlaybackTimer Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::updateTrackBlock Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::getTrackBlock Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::pushState Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::getTrack 0 Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioPushState Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::getTrack 0 Dec 19 13:49:17 volumio volumio[1462]: info: CoreStateMachine::serviceStop Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::getTrack 0 Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::serviceStop Dec 19 13:49:17 volumio volumio[1462]: info: ControllerMpd::stop Dec 19 13:49:17 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand stop Dec 19 13:49:17 volumio volumio[1462]: info: CoreCommandRouter::volumioPushQueue Dec 19 13:49:17 volumio volumio[1462]: info: CorePlayQueue::saveQueue Dec 19 13:49:18 volumio vtcs[2315]: [feedThread:276] Exiting Dec 19 13:49:18 volumio vtcs[2315]: [close:100] Exiting Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::updateTrackBlock Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrackBlock Dec 19 13:49:18 volumio volumio[1462]: info: PlaybackInactive Dec 19 13:49:18 volumio volumio[1462]: info: Device Session is_active: true Dec 19 13:49:18 volumio volumio[1462]: info: DeviceInactive Dec 19 13:49:18 volumio volumio[1462]: info: Relinquishing Volumio State Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand stop took 28 milliseconds Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::play index undefined Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::startPlaybackTimer Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::clearAddPlayTracks USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand stop Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand stop took 0 milliseconds Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand clear Dec 19 13:49:18 volumio volumio[1462]: info: Dec 19 13:49:18 volumio volumio[1462]: ---------------------------- MPD announces system playlist update Dec 19 13:49:18 volumio volumio[1462]: info: Ignoring MPD Status Update Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand clear took 1 milliseconds Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand add "USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac" Dec 19 13:49:18 volumio volumio[1462]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 19 13:49:18 volumio volumio[1462]: error: updateQueue error: null Dec 19 13:49:18 volumio volumio[1462]: info: Dec 19 13:49:18 volumio volumio[1462]: ---------------------------- MPD announces system playlist update Dec 19 13:49:18 volumio volumio[1462]: info: Ignoring MPD Status Update Dec 19 13:49:18 volumio volumio[1462]: info: ------------------------------ 3ms Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand add "USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac" took 2 milliseconds Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand play Dec 19 13:49:18 volumio volumio[1462]: info: ------------------------------ 2ms Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand play took 2 milliseconds Dec 19 13:49:18 volumio volumio[1462]: info: Dec 19 13:49:18 volumio volumio[1462]: ---------------------------- MPD announces state update: player Dec 19 13:49:18 volumio volumio[1462]: info: ControllerMpd::getState Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:49:18 volumio volumio[1462]: info: Dec 19 13:49:18 volumio volumio[1462]: ---------------------------- MPD announces state update: player Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand status took 10 milliseconds Dec 19 13:49:18 volumio volumio[1462]: info: ControllerMpd::getState Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::parseState Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::parseState Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:49:18 volumio volumio[1462]: info: ControllerMpd::pushState Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::servicePushState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":323,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"885 Kbps","isStreaming":false,"title":"Lily Was Here","artist":"Candy Dulfer","album":"Candy Dulfer Live In Amsterdam","uri":"USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac","trackType":"flac"} Dec 19 13:49:18 volumio volumio[1462]: verbose: CURRENT POSITION 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::syncState stateService play Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::syncState currentStatus stop Dec 19 13:49:18 volumio volumio[1462]: info: ------------------------------ 17ms Dec 19 13:49:18 volumio volumio[1462]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 19 13:49:18 volumio volumio[1462]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:49:18 volumio volumio[1462]: info: ControllerMpd::pushState Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::servicePushState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":323,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"832 Kbps","isStreaming":false,"title":"Lily Was Here","artist":"Candy Dulfer","album":"Candy Dulfer Live In Amsterdam","uri":"USB/D46E07D16E07AAF6/Teszt/Lily Was Here.flac","trackType":"flac"} Dec 19 13:49:18 volumio volumio[1462]: verbose: CURRENT POSITION 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::syncState stateService play Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::syncState currentStatus play Dec 19 13:49:18 volumio volumio[1462]: info: Received an update from plugin. extracting info from payload Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::pushState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::volumioPushState Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreStateMachine::pushState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::volumioPushState Dec 19 13:49:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:49:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:49:18 volumio volumio[1462]: info: ------------------------------ 27ms Dec 19 13:49:18 volumio volumio[1462]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 19 13:49:18 volumio vtcs[2315]: [2025-12-19 13:49:18.329] [tisoc] [warning] [PlaybackControllerImpl.cpp:520] Illegal state:0 Dec 19 13:49:26 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 68. Dec 19 13:49:26 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:26 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:26 volumio upmpdcli[4285]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:49:26 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:49:26 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:49:35 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 19 13:49:35 volumio volumio[1462]: info: CURURI: artists:// Dec 19 13:49:35 volumio volumio[1462]: info: Preload queue cleared Dec 19 13:49:41 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 69. Dec 19 13:49:41 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:41 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:41 volumio upmpdcli[4304]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:49:41 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:49:41 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:49:44 volumio volumio[1462]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 13:49:44 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 13:49:44 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 19 13:49:44 volumio sudo[4311]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 19 13:49:44 volumio sudo[4311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4316]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:49:44 volumio sudo[4316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4323]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:49:44 volumio sudo[4323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4316]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio sudo[4311]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio sudo[4327]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:49:44 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4323]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:44 volumio sudo[4327]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:44 volumio sudo[4333]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:49:44 volumio sudo[4339]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:49:44 volumio sudo[4339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4339]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio sudo[4333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:44 volumio sudo[4341]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:44 volumio sudo[4333]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:44 volumio sudo[4341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:46 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:46 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:46 volumio sudo[4361]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:46 volumio sudo[4361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:46 volumio sudo[4361]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:46 volumio volumio[1462]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 13:49:46 volumio volumio[1462]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 13:49:46 volumio volumio[1462]: info: Cannot use regular scanning, forcing with ap-force Dec 19 13:49:46 volumio sudo[4365]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 13:49:46 volumio sudo[4365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:46 volumio sudo[4365]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:46 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:46 volumio volumio[1462]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 13:49:46 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:47 volumio sudo[4341]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:48 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:48 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:48 volumio sudo[4369]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:48 volumio sudo[4369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:50 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:50 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:50 volumio sudo[4372]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:50 volumio sudo[4372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:50 volumio sudo[4372]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:50 volumio volumio[1462]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 13:49:50 volumio volumio[1462]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 13:49:50 volumio volumio[1462]: info: Cannot use regular scanning, forcing with ap-force Dec 19 13:49:50 volumio sudo[4376]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 13:49:50 volumio sudo[4376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:50 volumio sudo[4376]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:50 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:50 volumio volumio[1462]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 13:49:50 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:51 volumio sudo[4369]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:52 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:52 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:52 volumio sudo[4379]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:52 volumio sudo[4379]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:54 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:54 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:54 volumio sudo[4385]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:54 volumio sudo[4385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:54 volumio sudo[4385]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:54 volumio volumio[1462]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 13:49:54 volumio volumio[1462]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 13:49:54 volumio volumio[1462]: info: Cannot use regular scanning, forcing with ap-force Dec 19 13:49:54 volumio sudo[4389]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 13:49:54 volumio sudo[4389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:54 volumio sudo[4389]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:54 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:54 volumio volumio[1462]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 13:49:54 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:55 volumio sudo[4379]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:56 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:56 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:56 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 70. Dec 19 13:49:56 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:56 volumio sudo[4407]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:56 volumio sudo[4407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:56 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:49:56 volumio upmpdcli[4406]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:49:56 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:49:56 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:49:58 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:49:58 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:49:58 volumio sudo[4410]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:49:58 volumio sudo[4410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:58 volumio sudo[4410]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:58 volumio volumio[1462]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 13:49:58 volumio volumio[1462]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 13:49:58 volumio volumio[1462]: info: Cannot use regular scanning, forcing with ap-force Dec 19 13:49:58 volumio sudo[4414]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 13:49:58 volumio sudo[4414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:49:58 volumio sudo[4414]: pam_unix(sudo:session): session closed for user root Dec 19 13:49:58 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:58 volumio volumio[1462]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 13:49:58 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:49:59 volumio sudo[4407]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:00 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:50:00 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:50:00 volumio sudo[4417]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:50:00 volumio sudo[4417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:02 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:50:02 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:50:02 volumio sudo[4420]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 13:50:02 volumio sudo[4420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:02 volumio sudo[4420]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:02 volumio volumio[1462]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 13:50:02 volumio volumio[1462]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 13:50:02 volumio volumio[1462]: info: Cannot use regular scanning, forcing with ap-force Dec 19 13:50:02 volumio sudo[4424]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 13:50:02 volumio sudo[4424]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:02 volumio sudo[4424]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:02 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:50:02 volumio volumio[1462]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 13:50:02 volumio volumio[1462]: command failed: Device or resource busy (-16) Dec 19 13:50:03 volumio sudo[4417]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:04 volumio volumio[1462]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 19 13:50:04 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 19 13:50:04 volumio sudo[4427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 19 13:50:04 volumio sudo[4427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:04 volumio sudo[4427]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:04 volumio sudo[4429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 19 13:50:04 volumio sudo[4429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:04 volumio sudo[4429]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:04 volumio volumio[1462]: info: Permissions for /etc/network/interfaces set Dec 19 13:50:04 volumio volumio[1462]: info: Restarting Wireless Network Dec 19 13:50:04 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 19 13:50:04 volumio volumio[1462]: info: Discovery: Restarting Advertising due to device name change Dec 19 13:50:04 volumio sudo[4432]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 19 13:50:04 volumio sudo[4432]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:04 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 19 13:50:04 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 19 13:50:04 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 19 13:50:04 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 19 13:50:04 volumio wireless.js[4439]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 19 13:50:04 volumio wireless.js[4439]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 19 13:50:04 volumio wireless.js[4439]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 19 13:50:04 volumio wireless.js[4439]: WIRELESS.JS: Cleaning previous... Dec 19 13:50:04 volumio sudo[4457]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 13:50:04 volumio sudo[4457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 13:50:04 volumio sudo[4457]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:04 volumio sudo[4459]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 13:50:04 volumio sudo[4459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 13:50:04 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:50:04 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:50:04 volumio sudo[4459]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:05 volumio wireless.js[4439]: WIRELESS.JS: Stopped aP Dec 19 13:50:05 volumio sudo[4467]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 13:50:05 volumio sudo[4467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:05 volumio sudo[4467]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:05 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 13:50:05 volumio sudo[4469]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 19 13:50:05 volumio sudo[4469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:05 volumio sudo[4469]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:05 volumio sudo[4477]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 13:50:05 volumio sudo[4477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:05 volumio sudo[4477]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:05 volumio sudo[4479]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 19 13:50:05 volumio sudo[4479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:05 volumio volumio[1462]: info: Discovery: A device disappeared from network Dec 19 13:50:05 volumio volumio[1462]: info: Discovery: Device volumio disappeared from network Dec 19 13:50:05 volumio volumio[1462]: info: Discovery: A device disappeared from network Dec 19 13:50:07 volumio sudo[4479]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:07 volumio wireless.js[4439]: WIRELESS.JS: Wireless Networking DISABLED, not starting wireless flow Dec 19 13:50:07 volumio wireless.js[4439]: WIRELESS.JS: Notified systemd about wireless ready Dec 19 13:50:07 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 19 13:50:07 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 19 13:50:07 volumio sudo[4432]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:09 volumio volumio[1462]: info: Discovery: Started advertising with name: Volumio Dec 19 13:50:10 volumio volumio[1462]: info: Discovery: adding df24e30c-44ac-4b73-8d5b-6fc7342d5121 Dec 19 13:50:10 volumio volumio[1462]: info: Discovery: Found device Volumio Dec 19 13:50:10 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:10 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:10 volumio volumio[1462]: info: Discovery: this is already registered, df24e30c-44ac-4b73-8d5b-6fc7342d5121 Dec 19 13:50:10 volumio volumio[1462]: info: Discovery: Found device Volumio Dec 19 13:50:10 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:10 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:11 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 71. Dec 19 13:50:11 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:11 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:11 volumio upmpdcli[4503]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:50:11 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:50:11 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:50:12 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Dec 19 13:50:12 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Dec 19 13:50:12 volumio sudo[4505]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:50:12 volumio sudo[4505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:12 volumio sudo[4505]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:17 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Dec 19 13:50:17 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Dec 19 13:50:17 volumio volumio[1462]: info: Refreshing Cached IP Addresses Dec 19 13:50:17 volumio sudo[4526]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:50:17 volumio sudo[4528]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:50:17 volumio sudo[4528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:17 volumio sudo[4526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:17 volumio sudo[4528]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:17 volumio sudo[4526]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:18 volumio volumio[1462]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetVisibleSources Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 19 13:50:18 volumio volumio[1462]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 19 13:50:18 volumio volumio[1462]: info: Received Get System Info Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:50:18 volumio volumio[1462]: info: Discovery: Getting this device information Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:18 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:18 volumio volumio[1462]: info: Listing playlists Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 19 13:50:18 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 13:50:19 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 19 13:50:19 volumio sudo[4546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 19 13:50:19 volumio sudo[4546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio sudo[4546]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:19 volumio sudo[4551]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:50:19 volumio sudo[4551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio sudo[4557]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:50:19 volumio sudo[4557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 13:50:19 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 13:50:19 volumio sudo[4551]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:19 volumio sudo[4563]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 19 13:50:19 volumio sudo[4563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio sudo[4563]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:19 volumio sudo[4557]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:19 volumio sudo[4569]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:50:19 volumio sudo[4569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio sudo[4569]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:19 volumio sudo[4572]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:50:19 volumio sudo[4572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:19 volumio sudo[4572]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 19 13:50:20 volumio volumio[1462]: info: Received Get System Info Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:50:20 volumio volumio[1462]: info: Discovery: Getting this device information Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:20 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 19 13:50:20 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 19 13:50:23 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 19 13:50:23 volumio volumio[1462]: info: Received Get System Info Dec 19 13:50:23 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:50:23 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:50:23 volumio volumio[1462]: info: Discovery: Getting this device information Dec 19 13:50:23 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:23 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:23 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:50:27 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 72. Dec 19 13:50:27 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:27 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:27 volumio upmpdcli[4591]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:50:27 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:50:27 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:50:28 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 19 13:50:36 volumio volumio[1462]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 19 13:50:36 volumio volumio[1462]: info: Received Get System Version Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 13:50:36 volumio volumio[1462]: info: Received Get System Info Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:50:36 volumio volumio[1462]: info: Discovery: Getting this device information Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::volumioGetState Dec 19 13:50:36 volumio volumio[1462]: info: CorePlayQueue::getTrack 2 Dec 19 13:50:36 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:50:42 volumio volumio[1462]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 19 13:50:42 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 19 13:50:42 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 73. Dec 19 13:50:42 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:42 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 19 13:50:42 volumio upmpdcli[4610]: Could not open config: /tmp/upmpdcli.conf Dec 19 13:50:42 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 19 13:50:42 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 19 13:50:51 volumio volumio[1462]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 19 13:50:51 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 19 13:50:51 volumio sudo[4626]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 19 13:50:51 volumio sudo[4626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:51 volumio sudo[4626]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:51 volumio sudo[4628]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 19 13:50:51 volumio sudo[4628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:51 volumio sudo[4628]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:51 volumio volumio[1462]: info: Permissions for /etc/network/interfaces set Dec 19 13:50:51 volumio volumio[1462]: info: Restarting Wireless Network Dec 19 13:50:51 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 19 13:50:51 volumio volumio[1462]: info: Discovery: Restarting Advertising due to device name change Dec 19 13:50:51 volumio sudo[4631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 19 13:50:51 volumio sudo[4631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:51 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 19 13:50:51 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 19 13:50:51 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 19 13:50:51 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 19 13:50:51 volumio wireless.js[4637]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 19 13:50:51 volumio wireless.js[4637]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 19 13:50:51 volumio wireless.js[4637]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 19 13:50:51 volumio wireless.js[4637]: WIRELESS.JS: Cleaning previous... Dec 19 13:50:51 volumio sudo[4655]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 13:50:51 volumio sudo[4655]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 13:50:51 volumio sudo[4655]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:51 volumio sudo[4657]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 13:50:51 volumio sudo[4657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 13:50:52 volumio sudo[4657]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:52 volumio wireless.js[4637]: WIRELESS.JS: Stopped aP Dec 19 13:50:52 volumio wireless.js[4637]: WIRELESS.JS: Wireless Networking DISABLED, not starting wireless flow Dec 19 13:50:52 volumio wireless.js[4637]: WIRELESS.JS: Notified systemd about wireless ready Dec 19 13:50:52 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 19 13:50:52 volumio sudo[4631]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:52 volumio volumio[1462]: info: Discovery: A device disappeared from network Dec 19 13:50:52 volumio volumio[1462]: info: Discovery: Device volumio disappeared from network Dec 19 13:50:52 volumio volumio[1462]: info: Discovery: A device disappeared from network Dec 19 13:50:56 volumio volumio[1462]: info: Discovery: Started advertising with name: Volumio Dec 19 13:50:57 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Dec 19 13:50:57 volumio volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Dec 19 13:50:57 volumio sudo[4686]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:50:57 volumio sudo[4686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:50:57 volumio sudo[4686]: pam_unix(sudo:session): session closed for user root Dec 19 13:50:57 volumio volumio[1462]: compat.c: read() failed: Resource temporarily unavailable Dec 19 13:50:57 volumio volumio[1462]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 13:50:57 volumio volumio[1462]: Error: dns service error: unknown Dec 19 13:50:57 volumio volumio[1462]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 19 13:50:57 volumio volumio[1462]: errorCode: -65537 Dec 19 13:50:57 volumio volumio[1462]: } Dec 19 13:50:57 volumio volumio[1462]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 13:50:57 volumio sudo[4703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-19 13:49' Dec 19 13:50:57 volumio sudo[4703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"