-- Logs begin at Fri 2025-06-27 16:38:18 CEST, end at Fri 2025-06-27 18:01:54 CEST. -- Jun 27 18:00:04 volumio volumio[1040]: verbose: New Socket.io Connection to 192.168.6.36 from 192.168.6.15 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jun 27 18:00:04 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 18:00:04 volumio volumio[1040]: info: CoreCommandRouter::volumioGetState Jun 27 18:00:04 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:04 volumio volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 18:00:04 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:00:04 volumio volumio[1040]: info: CoreCommandRouter::volumioGetQueue Jun 27 18:00:04 volumio volumio[1040]: info: CoreStateMachine::getQueue Jun 27 18:00:04 volumio volumio[1040]: info: CorePlayQueue::getQueue Jun 27 18:00:04 volumio volumio[1040]: info: Listing playlists Jun 27 18:00:11 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 18:00:13 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 18:00:27 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 18:00:27 volumio volumio[1040]: info: CURURI: music-library/INTERNAL/America Jun 27 18:00:27 volumio volumio[1040]: info: Preload queue cleared Jun 27 18:00:35 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 18:00:35 volumio volumio[1040]: info: CURURI: music-library/INTERNAL/America/1976 - Hideaway Jun 27 18:00:35 volumio volumio[1040]: info: Preload queue cleared Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/01 - Lovely Night.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/02 - Amber Cascades.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/03 - Don't Let It Get You Down.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/04 - Can't You See.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/05 - Watership Down.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/06 - She's Beside You.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/07 - Hideaway Part I.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/08 - She's A Liar.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/09 - Letter.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/10 - Today's The Day.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/11 - Jet Boy Blue.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/12 - Who Love's You.flac Jun 27 18:00:35 volumio volumio[1040]: info: Preloading song: music-library/INTERNAL/America/1976 - Hideaway/13 - Hideaway Part II.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/01 - Lovely Night.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F01%20-%20Lovely%20Night.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/01 - Lovely Night.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/02 - Amber Cascades.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F02%20-%20Amber%20Cascades.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/02 - Amber Cascades.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/03 - Don't Let It Get You Down.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F03%20-%20Don't%20Let%20It%20Get%20You%20Down.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/03 - Don't Let It Get You Down.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/04 - Can't You See.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F04%20-%20Can't%20You%20See.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/04 - Can't You See.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/05 - Watership Down.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F05%20-%20Watership%20Down.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/05 - Watership Down.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/06 - She's Beside You.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F06%20-%20She's%20Beside%20You.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/06 - She's Beside You.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/07 - Hideaway Part I.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F07%20-%20Hideaway%20Part%20I.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/07 - Hideaway Part I.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/08 - She's A Liar.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F08%20-%20She's%20A%20Liar.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/08 - She's A Liar.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/09 - Letter.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F09%20-%20Letter.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/09 - Letter.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/10 - Today's The Day.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F10%20-%20Today's%20The%20Day.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/10 - Today's The Day.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/11 - Jet Boy Blue.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F11%20-%20Jet%20Boy%20Blue.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/11 - Jet Boy Blue.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/12 - Who Love's You.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F12%20-%20Who%20Love's%20You.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/12 - Who Love's You.flac Jun 27 18:00:35 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway/13 - Hideaway Part II.flac in service mpd Jun 27 18:00:35 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F13%20-%20Hideaway%20Part%20II.flac&metadata=false Jun 27 18:00:35 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/13 - Hideaway Part II.flac Jun 27 18:00:43 volumio volumio[1040]: info: CoreCommandRouter::volumioAddQueueItems Jun 27 18:00:43 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Jun 27 18:00:43 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Jun 27 18:00:43 volumio volumio[1040]: info: Preload queue cleared Jun 27 18:00:43 volumio volumio[1040]: info: Adding Item to queue: music-library/INTERNAL/America/1976 - Hideaway Jun 27 18:00:43 volumio volumio[1040]: info: Exploding uri music-library/INTERNAL/America/1976 - Hideaway in service mpd Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F01%20-%20Lovely%20Night.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/01 - Lovely Night.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F02%20-%20Amber%20Cascades.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/02 - Amber Cascades.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F03%20-%20Don't%20Let%20It%20Get%20You%20Down.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/03 - Don't Let It Get You Down.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F04%20-%20Can't%20You%20See.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/04 - Can't You See.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F05%20-%20Watership%20Down.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/05 - Watership Down.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F06%20-%20She's%20Beside%20You.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/06 - She's Beside You.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F07%20-%20Hideaway%20Part%20I.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/07 - Hideaway Part I.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F08%20-%20She's%20A%20Liar.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/08 - She's A Liar.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F09%20-%20Letter.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/09 - Letter.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F10%20-%20Today's%20The%20Day.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/10 - Today's The Day.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F11%20-%20Jet%20Boy%20Blue.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/11 - Jet Boy Blue.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F12%20-%20Who%20Love's%20You.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/12 - Who Love's You.flac Jun 27 18:00:43 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=552&web=America/Hideaway/extralarge&path=%2Fmnt%2FINTERNAL%2FAmerica%2F1976%20-%20Hideaway%2F13%20-%20Hideaway%20Part%20II.flac&metadata=false Jun 27 18:00:43 volumio volumio[1040]: info: URI /mnt/INTERNAL/America/1976 - Hideaway/13 - Hideaway Part II.flac Jun 27 18:00:43 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Jun 27 18:00:43 volumio volumio[1040]: info: CorePlayQueue::saveQueue Jun 27 18:00:43 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Jun 27 18:00:43 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Jun 27 18:00:43 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:43 volumio volumio[1040]: info: CorePlayQueue::getTrack 19 Jun 27 18:00:43 volumio volumio[1040]: info: Prefetching next song Jun 27 18:00:43 volumio volumio[1040]: info: DOING PREFETCH IN MPD Jun 27 18:00:43 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Alaska/1984 - Heart Of The Storm/08 - Other Side Of Midnight.flac" Jun 27 18:00:43 volumio volumio[1040]: info: Jun 27 18:00:43 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Jun 27 18:00:43 volumio volumio[1040]: info: Ignoring MPD Status Update Jun 27 18:00:43 volumio volumio[1040]: info: sendMpdCommand add "INTERNAL/Alaska/1984 - Heart Of The Storm/08 - Other Side Of Midnight.flac" took 0 milliseconds Jun 27 18:00:43 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 27 18:00:43 volumio volumio[1040]: info: Jun 27 18:00:43 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Jun 27 18:00:43 volumio volumio[1040]: info: Ignoring MPD Status Update Jun 27 18:00:43 volumio volumio[1040]: info: ------------------------------ 1ms Jun 27 18:00:43 volumio volumio[1040]: info: sendMpdCommand consume 1 took 1 milliseconds Jun 27 18:00:43 volumio volumio[1040]: info: ------------------------------ 1ms Jun 27 18:00:48 volumio volumio[1040]: info: Jun 27 18:00:48 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Jun 27 18:00:48 volumio volumio[1040]: info: Ignoring MPD Status Update Jun 27 18:00:48 volumio volumio[1040]: info: Jun 27 18:00:48 volumio volumio[1040]: ---------------------------- MPD announces state update: player Jun 27 18:00:48 volumio volumio[1040]: info: ControllerMpd::getState Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Jun 27 18:00:48 volumio volumio[1040]: info: Jun 27 18:00:48 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Jun 27 18:00:48 volumio volumio[1040]: info: Ignoring MPD Status Update Jun 27 18:00:48 volumio volumio[1040]: info: Jun 27 18:00:48 volumio volumio[1040]: ---------------------------- MPD announces state update: player Jun 27 18:00:48 volumio volumio[1040]: info: ControllerMpd::getState Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Jun 27 18:00:48 volumio volumio[1040]: info: ------------------------------ 2ms Jun 27 18:00:48 volumio volumio[1040]: info: sendMpdCommand status took 1 milliseconds Jun 27 18:00:48 volumio volumio[1040]: info: ------------------------------ 1ms Jun 27 18:00:48 volumio volumio[1040]: info: sendMpdCommand status took 0 milliseconds Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::parseState Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::parseState Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 18:00:48 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Jun 27 18:00:48 volumio volumio[1040]: info: ControllerMpd::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88,"duration":227,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4973 Kbps","isStreaming":false,"title":"Other Side Of Midnight","artist":"Alaska","album":"Heart Of The Storm","uri":"INTERNAL/Alaska/1984 - Heart Of The Storm/08 - Other Side Of Midnight.flac","trackType":"flac"} Jun 27 18:00:48 volumio volumio[1040]: verbose: CURRENT POSITION 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Jun 27 18:00:48 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:00:48 volumio volumio[1040]: info: ------------------------------ 11ms Jun 27 18:00:48 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 27 18:00:48 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Jun 27 18:00:48 volumio volumio[1040]: info: ControllerMpd::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88,"duration":227,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4973 Kbps","isStreaming":false,"title":"Other Side Of Midnight","artist":"Alaska","album":"Heart Of The Storm","uri":"INTERNAL/Alaska/1984 - Heart Of The Storm/08 - Other Side Of Midnight.flac","trackType":"flac"} Jun 27 18:00:48 volumio volumio[1040]: verbose: CURRENT POSITION 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Jun 27 18:00:48 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 18 Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:00:48 volumio volumio[1040]: info: ------------------------------ 15ms Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 19 Jun 27 18:00:48 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:00:48 volumio volumio[1040]: info: CorePlayQueue::getTrack 19 Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 18:00:48 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:00:55 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 18:00:55 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 27 18:01:00 volumio volumio[1040]: info: Enabling plugin 80s80s Jun 27 18:01:00 volumio volumio[1040]: info: Loading plugin "80s80s"... Jun 27 18:01:00 volumio volumio[1040]: info: [1751040060839] [80s80s] API delay: 30 Jun 27 18:01:00 volumio volumio[1040]: info: PLUGIN START: 80s80s Jun 27 18:01:00 volumio volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 18:01:00 volumio volumio[1040]: info: [1751040060841] CoreMusicLibrary::Adding element 80s80s Radio Jun 27 18:01:00 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:01:00 volumio volumio[1040]: Cannot find translation for source 80s80s Radio Jun 27 18:01:00 volumio volumio[1040]: info: Done. Jun 27 18:01:02 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 18:01:07 volumio volumio[1040]: info: CALLMETHOD: music_service 80s80s updateConfig [object Object] Jun 27 18:01:07 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: 80s80s , updateConfig Jun 27 18:01:09 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 18:01:09 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 27 18:01:12 volumio volumio[1040]: info: Enabling plugin calmradio Jun 27 18:01:13 volumio volumio[1040]: info: Loading plugin "calmradio"... Jun 27 18:01:13 volumio volumio[1040]: info: PLUGIN START: calmradio Jun 27 18:01:13 volumio volumio[1040]: info: Adding Calm Radio to Browse Sources Jun 27 18:01:13 volumio volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 18:01:13 volumio volumio[1040]: info: [1751040073169] CoreMusicLibrary::Adding element Calm Radio Jun 27 18:01:13 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:01:13 volumio volumio[1040]: Cannot find translation for source 80s80s Radio Jun 27 18:01:13 volumio volumio[1040]: Cannot find translation for source Calm Radio Jun 27 18:01:13 volumio volumio[1040]: info: Done. Jun 27 18:01:15 volumio volumio[1040]: info: Enabling plugin motherearthradio Jun 27 18:01:15 volumio volumio[1040]: info: Loading plugin "motherearthradio"... Jun 27 18:01:15 volumio volumio[1040]: info: [1751040075557] [MotherEarth] API delay: 5 Jun 27 18:01:15 volumio volumio[1040]: info: PLUGIN START: motherearthradio Jun 27 18:01:15 volumio volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 18:01:15 volumio volumio[1040]: info: [1751040075559] CoreMusicLibrary::Adding element Mother Earth Radio Jun 27 18:01:15 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:01:15 volumio volumio[1040]: Cannot find translation for source 80s80s Radio Jun 27 18:01:15 volumio volumio[1040]: Cannot find translation for source Calm Radio Jun 27 18:01:15 volumio volumio[1040]: Cannot find translation for source Mother Earth Radio Jun 27 18:01:15 volumio volumio[1040]: info: Done. Jun 27 18:01:17 volumio volumio[1040]: info: Enabling plugin rad357pl Jun 27 18:01:17 volumio volumio[1040]: info: Loading plugin "rad357pl"... Jun 27 18:01:18 volumio volumio[1040]: info: [1751040078036] [rad357pl] API delay: 5 Jun 27 18:01:18 volumio volumio[1040]: info: PLUGIN START: rad357pl Jun 27 18:01:18 volumio volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 18:01:18 volumio volumio[1040]: info: [1751040078038] CoreMusicLibrary::Adding element RADIO 357 Jun 27 18:01:18 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:01:18 volumio volumio[1040]: Cannot find translation for source 80s80s Radio Jun 27 18:01:18 volumio volumio[1040]: Cannot find translation for source Calm Radio Jun 27 18:01:18 volumio volumio[1040]: Cannot find translation for source Mother Earth Radio Jun 27 18:01:18 volumio volumio[1040]: Cannot find translation for source RADIO 357 Jun 27 18:01:18 volumio volumio[1040]: info: Done. Jun 27 18:01:20 volumio volumio[1040]: info: Enabling plugin radio_paradise Jun 27 18:01:20 volumio volumio[1040]: info: Loading plugin "radio_paradise"... Jun 27 18:01:20 volumio volumio[1040]: info: [1751040080857] [RadioParadise] API delay: 5 Jun 27 18:01:20 volumio volumio[1040]: info: PLUGIN START: radio_paradise Jun 27 18:01:20 volumio volumio[1040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 18:01:20 volumio volumio[1040]: info: [1751040080858] CoreMusicLibrary::Adding element Radio Paradise Jun 27 18:01:20 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 18:01:20 volumio volumio[1040]: Cannot find translation for source 80s80s Radio Jun 27 18:01:20 volumio volumio[1040]: Cannot find translation for source Calm Radio Jun 27 18:01:20 volumio volumio[1040]: Cannot find translation for source Mother Earth Radio Jun 27 18:01:20 volumio volumio[1040]: Cannot find translation for source RADIO 357 Jun 27 18:01:20 volumio volumio[1040]: Cannot find translation for source Radio Paradise Jun 27 18:01:20 volumio volumio[1040]: info: Done. Jun 27 18:01:22 volumio volumio[1040]: info: Enabling plugin autostart Jun 27 18:01:22 volumio volumio[1040]: info: Loading plugin "autostart"... Jun 27 18:01:22 volumio volumio[1040]: info: AutoStart - onVolumioStart - read config.json Jun 27 18:01:22 volumio volumio[1040]: info: PLUGIN START: autostart Jun 27 18:01:22 volumio volumio[1040]: info: AutoStart - onStart Jun 27 18:01:22 volumio volumio[1040]: info: Done. Jun 27 18:01:29 volumio volumio[1040]: info: Enabling plugin Systeminfo Jun 27 18:01:29 volumio volumio[1040]: info: Loading plugin "Systeminfo"... Jun 27 18:01:29 volumio volumio[1040]: info: PLUGIN START: Systeminfo Jun 27 18:01:29 volumio volumio[1040]: info: Done. Jun 27 18:01:31 volumio volumio[1040]: info: Enabling plugin now_playing Jun 27 18:01:31 volumio volumio[1040]: info: Loading plugin "now_playing"... Jun 27 18:01:31 volumio volumio[1040]: error: !!!! WARNING !!!! Jun 27 18:01:31 volumio volumio[1040]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Jun 27 18:01:31 volumio volumio[1040]: Require stack: Jun 27 18:01:31 volumio volumio[1040]: - /data/plugins/user_interface/now_playing/dist/index.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/app/pluginmanager.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/app/index.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/index.js Jun 27 18:01:31 volumio volumio[1040]: error: Stack trace: Error: Cannot find module 'geo-tz' Jun 27 18:01:31 volumio volumio[1040]: Require stack: Jun 27 18:01:31 volumio volumio[1040]: - /data/plugins/user_interface/now_playing/dist/index.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/app/pluginmanager.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/app/index.js Jun 27 18:01:31 volumio volumio[1040]: - /volumio/index.js Jun 27 18:01:31 volumio volumio[1040]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Jun 27 18:01:31 volumio volumio[1040]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Jun 27 18:01:31 volumio volumio[1040]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jun 27 18:01:31 volumio volumio[1040]: at require (internal/modules/cjs/helpers.js:107:18) Jun 27 18:01:31 volumio volumio[1040]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jun 27 18:01:31 volumio volumio[1040]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jun 27 18:01:31 volumio volumio[1040]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jun 27 18:01:31 volumio volumio[1040]: at Module.load (internal/modules/cjs/loader.js:979:32) Jun 27 18:01:31 volumio volumio[1040]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jun 27 18:01:31 volumio volumio[1040]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jun 27 18:01:31 volumio volumio[1040]: at require (internal/modules/cjs/helpers.js:107:18) Jun 27 18:01:31 volumio volumio[1040]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jun 27 18:01:31 volumio volumio[1040]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 27 18:01:31 volumio volumio[1040]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 27 18:01:31 volumio volumio[1040]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jun 27 18:01:31 volumio volumio[1040]: error: !!!! WARNING !!!! Jun 27 18:01:31 volumio volumio[1040]: info: Done. Jun 27 18:01:41 volumio volumio[1040]: info: Enabling plugin now_playing Jun 27 18:01:41 volumio volumio[1040]: info: Loading plugin "now_playing"... Jun 27 18:01:41 volumio volumio[1040]: error: !!!! WARNING !!!! Jun 27 18:01:41 volumio volumio[1040]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Jun 27 18:01:41 volumio volumio[1040]: Require stack: Jun 27 18:01:41 volumio volumio[1040]: - /data/plugins/user_interface/now_playing/dist/index.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/app/pluginmanager.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/app/index.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/index.js Jun 27 18:01:41 volumio volumio[1040]: error: Stack trace: Error: Cannot find module 'geo-tz' Jun 27 18:01:41 volumio volumio[1040]: Require stack: Jun 27 18:01:41 volumio volumio[1040]: - /data/plugins/user_interface/now_playing/dist/index.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/app/pluginmanager.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/app/index.js Jun 27 18:01:41 volumio volumio[1040]: - /volumio/index.js Jun 27 18:01:41 volumio volumio[1040]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Jun 27 18:01:41 volumio volumio[1040]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Jun 27 18:01:41 volumio volumio[1040]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jun 27 18:01:41 volumio volumio[1040]: at require (internal/modules/cjs/helpers.js:107:18) Jun 27 18:01:41 volumio volumio[1040]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jun 27 18:01:41 volumio volumio[1040]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jun 27 18:01:41 volumio volumio[1040]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jun 27 18:01:41 volumio volumio[1040]: at Module.load (internal/modules/cjs/loader.js:979:32) Jun 27 18:01:41 volumio volumio[1040]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jun 27 18:01:41 volumio volumio[1040]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jun 27 18:01:41 volumio volumio[1040]: at require (internal/modules/cjs/helpers.js:107:18) Jun 27 18:01:41 volumio volumio[1040]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jun 27 18:01:41 volumio volumio[1040]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 27 18:01:41 volumio volumio[1040]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 27 18:01:41 volumio volumio[1040]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jun 27 18:01:41 volumio volumio[1040]: error: !!!! WARNING !!!! Jun 27 18:01:41 volumio volumio[1040]: info: Error: TypeError: Cannot read property 'printToastMessage' of null Jun 27 18:01:42 volumio volumio[1040]: info: AutoStart - Plugin is starting Jun 27 18:01:42 volumio volumio[1040]: info: CoreCommandRouter::volumioGetQueue Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::getQueue Jun 27 18:01:42 volumio volumio[1040]: info: CorePlayQueue::getQueue Jun 27 18:01:42 volumio volumio[1040]: info: AutoStart - start playing Jun 27 18:01:42 volumio volumio[1040]: info: AutoStart - start playing with no specific position Jun 27 18:01:42 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::play index 0 Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::stop Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Jun 27 18:01:42 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Jun 27 18:01:42 volumio volumio[1040]: info: CoreStateMachine::pushState Jun 27 18:01:42 volumio volumio[1040]: info: CorePlayQueue::getTrack 19 Jun 27 18:01:42 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 18:01:42 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Jun 27 18:01:51 volumio volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 18:01:53 volumio volumio[1040]: info: CALLMETHOD: user_interface Systeminfo getsysteminfo undefined Jun 27 18:01:53 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , getsysteminfo Jun 27 18:01:53 volumio sudo[13908]: pam_unix(sudo:auth): conversation failed Jun 27 18:01:53 volumio sudo[13908]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 27 18:01:54 volumio volumio[1040]: error: failed Error: Command failed: /bin/cat /proc/device-tree/model Jun 27 18:01:54 volumio volumio[1040]: /bin/cat: /proc/device-tree/model: No such file or directory Jun 27 18:01:54 volumio volumio[1040]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 18:01:54 volumio volumio[1040]: TypeError: Cannot read property 'printToastMessage' of null Jun 27 18:01:54 volumio volumio[1040]: at /volumio/app/index.js:1214:32 Jun 27 18:01:54 volumio volumio[1040]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jun 27 18:01:54 volumio volumio[1040]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jun 27 18:01:54 volumio volumio[1040]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1212:13) Jun 27 18:01:54 volumio volumio[1040]: at /data/plugins/user_interface/Systeminfo/index.js:285:29 Jun 27 18:01:54 volumio volumio[1040]: at ChildProcess.exithandler (child_process.js:390:5) Jun 27 18:01:54 volumio volumio[1040]: at ChildProcess.emit (events.js:400:28) Jun 27 18:01:54 volumio volumio[1040]: at maybeClose (internal/child_process.js:1088:16) Jun 27 18:01:54 volumio volumio[1040]: at Socket. (internal/child_process.js:446:11) Jun 27 18:01:54 volumio volumio[1040]: at Socket.emit (events.js:400:28) Jun 27 18:01:54 volumio volumio[1040]: at Pipe. (net.js:686:12) Jun 27 18:01:54 volumio volumio[1040]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 18:01:54 volumio sudo[14183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 18:00 Jun 27 18:01:54 volumio sudo[14183]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"