-- Logs begin at Sat 2025-03-08 19:24:24 +10, end at Sun 2025-03-09 12:53:39 +10. -- Mar 09 12:53:32 volumio volumio[1046]: info: peppy_screensaver: Start PeppyMeter Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioNext Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::next Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::stop Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::stPlaybackTimer Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::updateTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 451 Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioPushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::serviceStop Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 451 Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::serviceStop Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::stop Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces state update: player Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand stop took 9 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::getState Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::play index undefined Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::startPlaybackTimer Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::updateTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand status took 4 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand stop took 1 milliseconds Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::parseState Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces state update: player Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::getState Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces state update: player Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::getState Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand clear took 29 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand status took 25 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand status took 24 milliseconds Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::parseState Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::parseState Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::servicePushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioPushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::servicePushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioPushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 09 12:53:33 volumio volumio[1046]: info: ControllerMpd::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::servicePushState Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::pushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioPushState Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1010 Mar 09 12:53:33 volumio volumio[1046]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 58ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 49ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 48ms Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 39ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 4ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 3ms Mar 09 12:53:33 volumio volumio[1046]: info: touch_display: Setting screensaver timeout to 20 seconds. Mar 09 12:53:33 volumio volumio[1046]: info: CoreCommandRouter::volumioNext Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::next Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::stop Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::play index undefined Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1348 Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::startPlaybackTimer Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrack 1348 Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 12:53:33 volumio volumio[1046]: info: CoreStateMachine::updateTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: CorePlayQueue::getTrackBlock Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand stop took 2 milliseconds Mar 09 12:53:33 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: info: sendMpdCommand clear took 1 milliseconds Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: info: Mar 09 12:53:33 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:33 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: error: updateQueue error: null Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 9ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 4ms Mar 09 12:53:33 volumio volumio[1046]: info: ------------------------------ 3ms Mar 09 12:53:34 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1560.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D764c795f7e44e972211ee5e6d562b885c4a5f8e21c99b484de284542e020da0e%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2b21%2F0%2F93378%2F643aa33a.13816853.10443857%2F320.mp3&ext=.mp3" Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1560.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D764c795f7e44e972211ee5e6d562b885c4a5f8e21c99b484de284542e020da0e%2Clid%3D1560%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2b21%2F0%2F93378%2F643aa33a.13816853.10443857%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 09 12:53:34 volumio volumio[1046]: verbose: MPD COMMAND [object Object] Mar 09 12:53:34 volumio volumio[1046]: verbose: MPD COMMAND [object Object] Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 4ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 3ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 12:53:34 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand play Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 4ms Mar 09 12:53:34 volumio volumio[1046]: info: sendMpdCommand play took 3 milliseconds Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-104.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daab2016801be8787735520923cfce4023c69d05a95543a43ebab5b2caff43ecb%2Clid%3D1582%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67da94a2%2F0%2F126809%2F84fd4457.196403757.7.95006951%2Fflac&ext=.flac" Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-104.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daab2016801be8787735520923cfce4023c69d05a95543a43ebab5b2caff43ecb%2Clid%3D1582%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67da94a2%2F0%2F126809%2F84fd4457.196403757.7.95006951%2Fflac&ext=.flac" took 2 milliseconds Mar 09 12:53:34 volumio volumio[1046]: verbose: MPD COMMAND [object Object] Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 3ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 12:53:34 volumio volumio[1046]: verbose: ControllerMpd::sendMpdCommand play Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: Mar 09 12:53:34 volumio volumio[1046]: ---------------------------- MPD announces system playlist update Mar 09 12:53:34 volumio volumio[1046]: info: Ignoring MPD Status Update Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 4ms Mar 09 12:53:34 volumio volumio[1046]: info: sendMpdCommand play took 3 milliseconds Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:34 volumio volumio[1046]: info: ------------------------------ 2ms Mar 09 12:53:39 volumio volumio[1046]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 12:53:39 volumio volumio[1046]: Error: getaddrinfo ENOTFOUND 1560.cold-rtc.strm.yandex.net Mar 09 12:53:39 volumio volumio[1046]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Mar 09 12:53:39 volumio volumio[1046]: errno: -3007, Mar 09 12:53:39 volumio volumio[1046]: code: 'ENOTFOUND', Mar 09 12:53:39 volumio volumio[1046]: syscall: 'getaddrinfo', Mar 09 12:53:39 volumio volumio[1046]: hostname: '1560.cold-rtc.strm.yandex.net' Mar 09 12:53:39 volumio volumio[1046]: } Mar 09 12:53:39 volumio volumio[1046]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 12:53:39 volumio sudo[3665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-09 12:52 Mar 09 12:53:39 volumio sudo[3665]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"