-- Logs begin at Sat 2025-09-06 07:32:12 UTC, end at Sat 2025-09-06 07:55:43 UTC. -- Sep 06 07:54:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 07:54:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 07:54:26 volumio volumio[1262]: info: Discovery: Getting this device information Sep 06 07:54:26 volumio volumio[1262]: info: CoreCommandRouter::volumioGetState Sep 06 07:54:26 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 07:54:28 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:28 volumio volumio[1262]: info: CorePlayQueue::getTrack 9 Sep 06 07:54:28 volumio volumio[1262]: info: Prefetching next song Sep 06 07:54:28 volumio volumio[1262]: info: DOING PREFETCH IN MPD Sep 06 07:54:28 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/nhac_lossless/nhac_quoc_te/Nhac_Vocal/VA/Dave's True Story - Dave's True Story (1993) [FLAC]/10 - Like A Rock - Dave's True Story.flac" Sep 06 07:54:28 volumio volumio[1262]: info: sendMpdCommand add "INTERNAL/nhac_lossless/nhac_quoc_te/Nhac_Vocal/VA/Dave's True Story - Dave's True Story (1993) [FLAC]/10 - Like A Rock - Dave's True Story.flac" took 0 milliseconds Sep 06 07:54:28 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 06 07:54:28 volumio volumio[1262]: info: Sep 06 07:54:28 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Sep 06 07:54:28 volumio volumio[1262]: info: Ignoring MPD Status Update Sep 06 07:54:28 volumio volumio[1262]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 06 07:54:28 volumio volumio[1262]: info: Sep 06 07:54:28 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Sep 06 07:54:28 volumio volumio[1262]: info: Ignoring MPD Status Update Sep 06 07:54:28 volumio volumio[1262]: info: ------------------------------ 2ms Sep 06 07:54:28 volumio volumio[1262]: info: ------------------------------ 2ms Sep 06 07:54:32 volumio volumio[1262]: info: Sep 06 07:54:32 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Sep 06 07:54:32 volumio volumio[1262]: info: Ignoring MPD Status Update Sep 06 07:54:32 volumio volumio[1262]: info: Sep 06 07:54:32 volumio volumio[1262]: ---------------------------- MPD announces state update: player Sep 06 07:54:32 volumio volumio[1262]: info: ControllerMpd::getState Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Sep 06 07:54:32 volumio volumio[1262]: info: Sep 06 07:54:32 volumio volumio[1262]: ---------------------------- MPD announces system playlist update Sep 06 07:54:32 volumio volumio[1262]: info: Ignoring MPD Status Update Sep 06 07:54:32 volumio volumio[1262]: info: Sep 06 07:54:32 volumio volumio[1262]: ---------------------------- MPD announces state update: player Sep 06 07:54:32 volumio volumio[1262]: info: ControllerMpd::getState Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand status Sep 06 07:54:32 volumio volumio[1262]: info: ------------------------------ 5ms Sep 06 07:54:32 volumio volumio[1262]: info: sendMpdCommand status took 5 milliseconds Sep 06 07:54:32 volumio volumio[1262]: info: ------------------------------ 5ms Sep 06 07:54:32 volumio volumio[1262]: info: sendMpdCommand status took 4 milliseconds Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::parseState Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::parseState Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 06 07:54:32 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 07:54:32 volumio volumio[1262]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Sep 06 07:54:32 volumio volumio[1262]: verbose: ControllerMpd::parseTrackInfo Sep 06 07:54:32 volumio volumio[1262]: info: ControllerMpd::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"550 Kbps","isStreaming":false,"title":"Like A Rock","artist":"Dave's True Story","album":"Dave's True Story","uri":"INTERNAL/nhac_lossless/nhac_quoc_te/Nhac_Vocal/VA/Dave's True Story - Dave's True Story (1993) [FLAC]/10 - Like A Rock - Dave's True Story.flac","trackType":"flac"} Sep 06 07:54:32 volumio volumio[1262]: verbose: CURRENT POSITION 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Sep 06 07:54:32 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Sep 06 07:54:32 volumio volumio[1262]: info: ControllerMpd::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::servicePushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"550 Kbps","isStreaming":false,"title":"Like A Rock","artist":"Dave's True Story","album":"Dave's True Story","uri":"INTERNAL/nhac_lossless/nhac_quoc_te/Nhac_Vocal/VA/Dave's True Story - Dave's True Story (1993) [FLAC]/10 - Like A Rock - Dave's True Story.flac","trackType":"flac"} Sep 06 07:54:32 volumio volumio[1262]: verbose: CURRENT POSITION 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::syncState stateService play Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::syncState currentStatus play Sep 06 07:54:32 volumio volumio[1262]: info: Received an update from plugin. extracting info from payload Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Sep 06 07:54:32 volumio volumio[1262]: info: CoreStateMachine::pushState Sep 06 07:54:32 volumio volumio[1262]: info: CorePlayQueue::getTrack 0 Sep 06 07:54:32 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Sep 06 07:54:32 volumio volumio[1262]: info: ------------------------------ 24ms Sep 06 07:54:32 volumio volumio[1262]: info: PeppySpectrum ---peppyspectrum status play Sep 06 07:54:32 volumio volumio[1262]: info: PeppySpectrum ---peppyspectrum status play Sep 06 07:54:32 volumio sudo[7001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Sep 06 07:54:32 volumio sudo[7001]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 07:54:32 volumio sudo[7001]: pam_unix(sudo:session): session closed for user root Sep 06 07:54:32 volumio volumio[1262]: info: PeppySpectrum ---peppyspectrum status play Sep 06 07:54:32 volumio sudo[7004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Sep 06 07:54:32 volumio sudo[7004]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 07:54:32 volumio sudo[7004]: pam_unix(sudo:session): session closed for user root Sep 06 07:54:32 volumio volumio[1262]: info: PeppySpectrum ---peppyspectrum status play Sep 06 07:54:32 volumio sudo[7007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Sep 06 07:54:32 volumio sudo[7007]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 07:54:32 volumio sudo[7007]: pam_unix(sudo:session): session closed for user root Sep 06 07:54:32 volumio volumio[1262]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Sep 06 07:54:32 volumio volumio[1262]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Sep 06 07:54:32 volumio volumio[1262]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Sep 06 07:54:32 volumio volumio[1262]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Sep 06 07:54:32 volumio sudo[7010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Sep 06 07:54:32 volumio sudo[7010]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 07:54:32 volumio volumio[1262]: info: peppyspectrum Daemon Started Sep 06 07:54:32 volumio volumio[1262]: info: peppyspectrum Daemon Started Sep 06 07:54:32 volumio volumio[1262]: info: peppyspectrum Daemon Started Sep 06 07:54:32 volumio sudo[7010]: pam_unix(sudo:session): session closed for user root Sep 06 07:54:32 volumio volumio[1262]: info: peppyspectrum Daemon Started Sep 06 07:54:33 volumio volumio[1262]: info: CoreStateMachine::startPlaybackTimer Sep 06 07:54:33 volumio volumio[1262]: info: CorePlayQueue::getTrack 9 Sep 06 07:54:33 volumio volumio[1262]: info: CoreStateMachine::pushState Sep 06 07:54:33 volumio volumio[1262]: info: CorePlayQueue::getTrack 9 Sep 06 07:54:33 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 06 07:54:33 volumio volumio[1262]: info: CoreCommandRouter::volumioPushState Sep 06 07:54:33 volumio volumio[1262]: info: PeppySpectrum ---peppyspectrum status play Sep 06 07:54:33 volumio sudo[7013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Sep 06 07:54:33 volumio sudo[7013]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 06 07:54:33 volumio volumio[1262]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Sep 06 07:54:33 volumio sudo[7013]: pam_unix(sudo:session): session closed for user root Sep 06 07:54:33 volumio volumio[1262]: info: peppyspectrum Daemon Started Sep 06 07:54:34 volumio ntpd[1416]: Soliciting pool server 103.184.124.254 Sep 06 07:54:41 volumio ntpd[1416]: Soliciting pool server 115.165.161.155 Sep 06 07:54:42 volumio ntpd[1416]: Soliciting pool server 115.165.161.155 Sep 06 07:54:48 volumio ntpd[1416]: Soliciting pool server 103.184.124.254 Sep 06 07:54:56 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 07:54:56 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 07:54:56 volumio volumio[1262]: info: Discovery: Getting this device information Sep 06 07:54:56 volumio volumio[1262]: info: CoreCommandRouter::volumioGetState Sep 06 07:54:56 volumio volumio[1262]: info: CorePlayQueue::getTrack 9 Sep 06 07:54:56 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 07:55:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 06 07:55:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 06 07:55:26 volumio volumio[1262]: info: Discovery: Getting this device information Sep 06 07:55:26 volumio volumio[1262]: info: CoreCommandRouter::volumioGetState Sep 06 07:55:26 volumio volumio[1262]: info: CorePlayQueue::getTrack 9 Sep 06 07:55:26 volumio volumio[1262]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 06 07:55:39 volumio ntpd[1416]: Soliciting pool server 115.165.161.155 Sep 06 07:55:43 volumio volumio[1262]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 07:55:43 volumio volumio[1262]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net Sep 06 07:55:43 volumio volumio[1262]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Sep 06 07:55:43 volumio volumio[1262]: errno: -3007, Sep 06 07:55:43 volumio volumio[1262]: code: 'ENOTFOUND', Sep 06 07:55:43 volumio volumio[1262]: syscall: 'getaddrinfo', Sep 06 07:55:43 volumio volumio[1262]: hostname: 'lastfm.freetls.fastly.net' Sep 06 07:55:43 volumio volumio[1262]: } Sep 06 07:55:43 volumio volumio[1262]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 06 07:55:43 volumio sudo[7189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-06 07:54 Sep 06 07:55:43 volumio sudo[7189]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"