-- Logs begin at Thu 2019-02-14 13:12:01 MSK, end at Thu 2025-12-11 22:14:58 MSK. -- Dec 11 22:13:17 volumio dhcpcd[1083]: eth0: failed to renew DHCP, rebinding Dec 11 22:13:17 volumio dhcpcd[1083]: eth0: adding route to 192.168.2.0/24 Dec 11 22:13:17 volumio dhcpcd[1083]: eth0: adding default route via 192.168.2.1 Dec 11 22:14:40 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri Dec 11 22:14:40 volumio volumio[1126]: info: Preload queue cleared Dec 11 22:14:41 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri Dec 11 22:14:43 volumio volumio[1126]: info: Preload queue cleared Dec 11 22:14:43 volumio volumio[1126]: info: Preloading song: yandex_music/track/90259189:17810441@user:onyourwave Dec 11 22:14:43 volumio volumio[1126]: info: Preloading song: yandex_music/track/138301945:36267078@user:onyourwave Dec 11 22:14:43 volumio volumio[1126]: info: Preloading song: yandex_music/track/145354180:39288143@user:onyourwave Dec 11 22:14:43 volumio volumio[1126]: info: Exploding uri yandex_music/track/90259189:17810441@user:onyourwave in service yandex_music Dec 11 22:14:43 volumio volumio[1126]: info: Exploding uri yandex_music/track/138301945:36267078@user:onyourwave in service yandex_music Dec 11 22:14:43 volumio volumio[1126]: info: Exploding uri yandex_music/track/145354180:39288143@user:onyourwave in service yandex_music Dec 11 22:14:44 volumio volumio[1126]: info: Preload queue cleared Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::ClearQueue Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::stop Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::stPlaybackTimer Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::pushState Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 1 Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::serviceStop Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 1 Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::serviceStop Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 22:14:44 volumio volumio[1126]: info: ControllerMpd::stop Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::clearPlayQueue Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::saveQueue Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::addQueueItems Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::addQueueItems Dec 11 22:14:44 volumio volumio[1126]: info: Preload queue cleared Dec 11 22:14:44 volumio volumio[1126]: info: Adding Item to queue: yandex_music/track/90259189:17810441@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Using cached record of: yandex_music/track/90259189:17810441@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::saveQueue Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPlay Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::play index 0 Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::addQueueItems Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::addQueueItems Dec 11 22:14:44 volumio volumio[1126]: info: Preload queue cleared Dec 11 22:14:44 volumio volumio[1126]: info: Adding Item to queue: yandex_music/track/138301945:36267078@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Using cached record of: yandex_music/track/138301945:36267078@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Adding Item to queue: yandex_music/track/145354180:39288143@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Using cached record of: yandex_music/track/145354180:39288143@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Adding Item to queue: yandex_music/track/96495805:19770053@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Using cached record of: yandex_music/track/96495805:19770053@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Adding Item to queue: yandex_music/track/113541525:25746269@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: Using cached record of: yandex_music/track/113541525:25746269@user:onyourwave Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::stop Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPushQueue Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::saveQueue Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::play index undefined Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::updateTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrackBlock Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 0 Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::startPlaybackTimer Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 0 Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces state update: player Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand stop took 15 milliseconds Dec 11 22:14:44 volumio volumio[1126]: info: ControllerMpd::getState Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand stop took 6 milliseconds Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces state update: player Dec 11 22:14:44 volumio volumio[1126]: info: ControllerMpd::getState Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand status Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand clear took 1 milliseconds Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand status took 2 milliseconds Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::parseState Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::parseState Dec 11 22:14:44 volumio volumio[1126]: info: ControllerMpd::pushState Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::servicePushState Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::pushState Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 0 Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:14:44 volumio volumio[1126]: info: CoreCommandRouter::volumioPushState Dec 11 22:14:44 volumio volumio[1126]: info: CorePlayQueue::getTrack 0 Dec 11 22:14:44 volumio volumio[1126]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 5ms Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: error: updateQueue error: null Dec 11 22:14:44 volumio volumio[1126]: error: updateQueue error: null Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 8ms Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 1ms Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::parseTrackInfo Dec 11 22:14:44 volumio volumio[1126]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 11ms Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-156.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D5e7929c826c7a47d666e619f5339a7a78b3319e7ce3e915e69ef30163581a137%2Clid%3D87%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6948cd57%2F28127%2F4024526%2F4e8d41ed.136094034.9.90259189%2F320.mp3&ext=.mp3" Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-156.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D5e7929c826c7a47d666e619f5339a7a78b3319e7ce3e915e69ef30163581a137%2Clid%3D87%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6948cd57%2F28127%2F4024526%2F4e8d41ed.136094034.9.90259189%2F320.mp3&ext=.mp3" took 2 milliseconds Dec 11 22:14:44 volumio volumio[1126]: verbose: MPD COMMAND [object Object] Dec 11 22:14:44 volumio volumio[1126]: verbose: MPD COMMAND [object Object] Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 2ms Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 2ms Dec 11 22:14:44 volumio volumio[1126]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 22:14:44 volumio volumio[1126]: verbose: ControllerMpd::sendMpdCommand play Dec 11 22:14:44 volumio volumio[1126]: info: Dec 11 22:14:44 volumio volumio[1126]: ---------------------------- MPD announces system playlist update Dec 11 22:14:44 volumio volumio[1126]: info: Ignoring MPD Status Update Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 2ms Dec 11 22:14:44 volumio volumio[1126]: info: sendMpdCommand play took 1 milliseconds Dec 11 22:14:44 volumio volumio[1126]: info: ------------------------------ 1ms Dec 11 22:14:57 volumio volumio[1126]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 22:14:57 volumio volumio[1126]: Error: read ECONNRESET Dec 11 22:14:57 volumio volumio[1126]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Dec 11 22:14:57 volumio volumio[1126]: errno: -104, Dec 11 22:14:57 volumio volumio[1126]: code: 'ECONNRESET', Dec 11 22:14:57 volumio volumio[1126]: syscall: 'read' Dec 11 22:14:57 volumio volumio[1126]: } Dec 11 22:14:57 volumio volumio[1126]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 22:14:58 volumio sudo[22149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-11 22:13 Dec 11 22:14:58 volumio sudo[22149]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"