-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Thu 2025-10-30 21:22:35 MSK. -- Oct 30 21:21:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:21:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:21:10 volumio volumio[967]: info: Discovery: Getting this device information Oct 30 21:21:10 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:21:10 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:21:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:21:41 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:21:41 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:21:41 volumio volumio[967]: info: Discovery: Getting this device information Oct 30 21:21:41 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:21:41 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:21:41 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:21:56 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:21:56 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:21:56 volumio volumio[967]: info: Prefetching next song Oct 30 21:21:56 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-spbmiran-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0db09c2d6f2011cca327c06b9d8d792ada66d1ceb8e3da65f745f6fb79a0d02e%2Clid%3D234%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6911a897%2F0%2F230468%2Fa07ae9b7.197275797.7.17198451%2F320.mp3&ext=.mp3" Oct 30 21:21:56 volumio volumio[967]: info: Oct 30 21:21:56 volumio volumio[967]: ---------------------------- MPD announces system playlist update Oct 30 21:21:56 volumio volumio[967]: info: Ignoring MPD Status Update Oct 30 21:21:56 volumio volumio[967]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-spbmiran-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0db09c2d6f2011cca327c06b9d8d792ada66d1ceb8e3da65f745f6fb79a0d02e%2Clid%3D234%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6911a897%2F0%2F230468%2Fa07ae9b7.197275797.7.17198451%2F320.mp3&ext=.mp3" took 2 milliseconds Oct 30 21:21:56 volumio volumio[967]: verbose: MPD COMMAND [object Object] Oct 30 21:21:56 volumio volumio[967]: verbose: MPD COMMAND [object Object] Oct 30 21:21:56 volumio volumio[967]: verbose: MPD COMMAND [object Object] Oct 30 21:21:56 volumio volumio[967]: info: Oct 30 21:21:56 volumio volumio[967]: ---------------------------- MPD announces system playlist update Oct 30 21:21:56 volumio volumio[967]: info: Ignoring MPD Status Update Oct 30 21:21:56 volumio volumio[967]: info: ------------------------------ 2ms Oct 30 21:21:56 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 30 21:21:56 volumio volumio[967]: info: ------------------------------ 1ms Oct 30 21:21:56 volumio volumio[967]: info: sendMpdCommand consume 1 took 0 milliseconds Oct 30 21:22:00 volumio volumio[967]: verbose: New Socket.io Connection to 192.168.1.146 from 192.168.1.168 UA: Mozilla/5.0 (Linux; Android 15; CPH2653 Build/AP3A.240617.008; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:22:00 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 21:22:00 volumio volumio[967]: info: Received Get System Info Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:22:00 volumio volumio[967]: info: Discovery: Getting this device information Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:22:00 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:22:00 volumio volumio[967]: info: CorePlayQueue::getTrack 5 Oct 30 21:22:00 volumio volumio[967]: info: Listing playlists Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::volumioGetQueue Oct 30 21:22:00 volumio volumio[967]: info: CoreStateMachine::getQueue Oct 30 21:22:00 volumio volumio[967]: info: CorePlayQueue::getQueue Oct 30 21:22:00 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 30 21:22:00 volumio volumio[967]: info: CoreStateMachine::startPlaybackTimer Oct 30 21:22:00 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:01 volumio volumio[967]: info: Oct 30 21:22:01 volumio volumio[967]: ---------------------------- MPD announces system playlist update Oct 30 21:22:01 volumio volumio[967]: info: Ignoring MPD Status Update Oct 30 21:22:01 volumio volumio[967]: info: Oct 30 21:22:01 volumio volumio[967]: ---------------------------- MPD announces state update: player Oct 30 21:22:01 volumio volumio[967]: info: ControllerMpd::getState Oct 30 21:22:01 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Oct 30 21:22:01 volumio volumio[967]: info: ------------------------------ 2ms Oct 30 21:22:01 volumio volumio[967]: info: sendMpdCommand status took 1 milliseconds Oct 30 21:22:01 volumio volumio[967]: verbose: ControllerMpd::parseState Oct 30 21:22:01 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 21:22:01 volumio volumio[967]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 21:22:01 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo Oct 30 21:22:01 volumio volumio[967]: info: ControllerMpd::pushState Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::servicePushState Oct 30 21:22:01 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:01 volumio volumio[967]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":397,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Печальный Ангел","artist":"Игорь Крутой","album":"Без слов. . . Pt..2","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-spbmiran-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0db09c2d6f2011cca327c06b9d8d792ada66d1ceb8e3da65f745f6fb79a0d02e%2Clid%3D234%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6911a897%2F0%2F230468%2Fa07ae9b7.197275797.7.17198451%2F320.mp3&ext=.mp3","trackType":"mp3"} Oct 30 21:22:01 volumio volumio[967]: verbose: CURRENT POSITION 6 Oct 30 21:22:01 volumio volumio[967]: info: CoreStateMachine::syncState stateService play Oct 30 21:22:01 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus play Oct 30 21:22:01 volumio volumio[967]: info: Received an update from plugin. extracting info from payload Oct 30 21:22:01 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:01 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:01 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:01 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:01 volumio volumio[967]: info: ------------------------------ 51ms Oct 30 21:22:01 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:01 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:01 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:03 volumio volumio[967]: info: VolumeController::SetAlsaVolume60 Oct 30 21:22:03 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:03 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:03 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:03 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:03 volumio volumio[967]: info: VolumeController::SetAlsaVolume54 Oct 30 21:22:03 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:03 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:03 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:03 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:04 volumio volumio[967]: info: VolumeController::SetAlsaVolume53 Oct 30 21:22:04 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:04 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:22:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:22:10 volumio volumio[967]: info: Discovery: Getting this device information Oct 30 21:22:10 volumio volumio[967]: info: CoreCommandRouter::volumioGetState Oct 30 21:22:10 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:10 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 21:22:11 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 21:22:11 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 30 21:22:17 volumio volumio[967]: info: minidlna: Stopping minidlna.service Oct 30 21:22:17 volumio sudo[10305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop minidlna.service Oct 30 21:22:17 volumio sudo[10305]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:22:17 volumio systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Oct 30 21:22:17 volumio systemd[1]: minidlna.service: Succeeded. Oct 30 21:22:17 volumio systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Oct 30 21:22:17 volumio sudo[10305]: pam_unix(sudo:session): session closed for user root Oct 30 21:22:17 volumio volumio[967]: info: minidlna: systemctl stop minidlna.service succeeded. Oct 30 21:22:17 volumio volumio[967]: info: Disabling plugin minidlna Oct 30 21:22:17 volumio volumio[967]: info: Done. Oct 30 21:22:25 volumio volumio[967]: info: CoreCommandRouter::volumioPause Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::pause Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::servicePause Oct 30 21:22:25 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:25 volumio volumio[967]: info: CoreCommandRouter::servicePause Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 21:22:25 volumio volumio[967]: info: ControllerMpd::pause Oct 30 21:22:25 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand pause Oct 30 21:22:25 volumio volumio[967]: info: Oct 30 21:22:25 volumio volumio[967]: ---------------------------- MPD announces state update: player Oct 30 21:22:25 volumio volumio[967]: info: sendMpdCommand pause took 2 milliseconds Oct 30 21:22:25 volumio volumio[967]: info: ControllerMpd::getState Oct 30 21:22:25 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status Oct 30 21:22:25 volumio volumio[967]: info: sendMpdCommand status took 1 milliseconds Oct 30 21:22:25 volumio volumio[967]: verbose: ControllerMpd::parseState Oct 30 21:22:25 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 21:22:25 volumio volumio[967]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 30 21:22:25 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo Oct 30 21:22:25 volumio volumio[967]: info: ControllerMpd::pushState Oct 30 21:22:25 volumio volumio[967]: info: CoreCommandRouter::servicePushState Oct 30 21:22:25 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:25 volumio volumio[967]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24940,"duration":397,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Печальный Ангел","artist":"Игорь Крутой","album":"Без слов. . . Pt..2","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-spbmiran-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0db09c2d6f2011cca327c06b9d8d792ada66d1ceb8e3da65f745f6fb79a0d02e%2Clid%3D234%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6911a897%2F0%2F230468%2Fa07ae9b7.197275797.7.17198451%2F320.mp3&ext=.mp3","trackType":"mp3"} Oct 30 21:22:25 volumio volumio[967]: verbose: CURRENT POSITION 6 Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::syncState stateService pause Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus pause Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:25 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:25 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:25 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer Oct 30 21:22:26 volumio volumio[967]: info: ------------------------------ 35ms Oct 30 21:22:26 volumio volumio[967]: info: CoreCommandRouter::volumioGetQueue Oct 30 21:22:26 volumio volumio[967]: info: CoreStateMachine::getQueue Oct 30 21:22:26 volumio volumio[967]: info: CorePlayQueue::getQueue Oct 30 21:22:26 volumio volumio[967]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 30 21:22:27 volumio volumio[967]: info: peppy_screensaver: Start PeppyMeter Oct 30 21:22:28 volumio volumio[967]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesЯндекс Музыка Oct 30 21:22:28 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 21:22:28 volumio volumio[967]: Cannot find translation for source Calm Radio Oct 30 21:22:28 volumio volumio[967]: Cannot find translation for source Radio Paradise Oct 30 21:22:28 volumio volumio[967]: info: Disabling plugin yandex_music Oct 30 21:22:28 volumio volumio[967]: info: Done. Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::stop Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::updateTrackBlock Oct 30 21:22:35 volumio volumio[967]: info: CorePlayQueue::getTrackBlock Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::pushState Oct 30 21:22:35 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:35 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:22:35 volumio volumio[967]: info: CoreCommandRouter::volumioPushState Oct 30 21:22:35 volumio volumio[967]: info: CoreStateMachine::serviceStop Oct 30 21:22:35 volumio volumio[967]: info: CorePlayQueue::getTrack 6 Oct 30 21:22:35 volumio volumio[967]: info: CoreCommandRouter::serviceStop Oct 30 21:22:35 volumio volumio[967]: error: WARNING: No stop method for service yandex_music Oct 30 21:22:35 volumio volumio[967]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:22:35 volumio volumio[967]: TypeError: Cannot read property 'then' of undefined Oct 30 21:22:35 volumio volumio[967]: at peppyScreensaver.onStop (/data/plugins/user_interface/peppy_screensaver/index.js:243:43) Oct 30 21:22:35 volumio volumio[967]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 30 21:22:35 volumio volumio[967]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Oct 30 21:22:35 volumio volumio[967]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Oct 30 21:22:35 volumio volumio[967]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Oct 30 21:22:35 volumio volumio[967]: at Socket.emit (events.js:315:20) Oct 30 21:22:35 volumio volumio[967]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 30 21:22:35 volumio volumio[967]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 30 21:22:35 volumio volumio[967]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:22:35 volumio sudo[10374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 21:21 Oct 30 21:22:35 volumio sudo[10374]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"