-- Logs begin at Thu 2024-09-05 15:09:40 MSK, end at Thu 2024-09-05 15:58:22 MSK. -- Sep 05 15:57:04 volumio volumio[1012]: info: VolumeController::SetAlsaVolume65 Sep 05 15:57:04 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:04 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:04 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:04 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:04 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:04 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:04 volumio volumio[1012]: info: VolumeController::SetAlsaVolume75 Sep 05 15:57:04 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:04 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:04 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:04 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:04 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:04 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:05 volumio volumio[1012]: info: VolumeController::SetAlsaVolume80 Sep 05 15:57:05 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:05 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:05 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:05 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:05 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:06 volumio volumio[1012]: info: VolumeController::SetAlsaVolume85 Sep 05 15:57:06 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:06 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:06 volumio volumio[1012]: info: VolumeController::SetAlsaVolume90 Sep 05 15:57:06 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:06 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:06 volumio volumio[1012]: info: VolumeController::SetAlsaVolume95 Sep 05 15:57:06 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:06 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:06 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:06 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:07 volumio volumio[1012]: info: VolumeController::SetAlsaVolume100 Sep 05 15:57:07 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:07 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:07 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:07 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:07 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:08 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:08 volumio volumio[1012]: info: FusionDsp - {"Reload":{"result":"Ok"}} Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::volumioPause Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::pause Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::stPlaybackTimer Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::servicePause Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePause Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand pause Sep 05 15:57:20 volumio volumio[1012]: info: Sep 05 15:57:20 volumio volumio[1012]: ---------------------------- MPD announces state update: player Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand pause took 2 milliseconds Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::getState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand status Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: verbose: STATE SERVICE {"status":"pause","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is1-ssl.mzstatic.com/image/thumb/Music123/v4/1b/7f/d1/1b7fd100-9f6d-abaf-c19a-b316f5d4c78a/ANTCD-A0000000402.jpg/600x600bb.jpg","name":"Albert One - SECRETS","title":"SECRETS","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"217","seek":29089,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Sep 05 15:57:20 volumio volumio[1012]: verbose: CURRENT POSITION 0 Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::syncState stateService pause Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::syncState currentStatus pause Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::pushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::volumioPushState Sep 05 15:57:20 volumio volumio[1012]: info: CoreStateMachine::stPlaybackTimer Sep 05 15:57:20 volumio volumio[1012]: info: Sep 05 15:57:20 volumio volumio[1012]: ---------------------------- MPD announces state update: player Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::getState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand status Sep 05 15:57:20 volumio volumio[1012]: info: Sep 05 15:57:20 volumio volumio[1012]: ---------------------------- MPD announces state update: player Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::getState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand status Sep 05 15:57:20 volumio volumio[1012]: info: Sep 05 15:57:20 volumio volumio[1012]: ---------------------------- MPD announces state update: player Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::getState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand status Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand status took 9 milliseconds Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand status took 3 milliseconds Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand status took 2 milliseconds Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand status took 1 milliseconds Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseState Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 15:57:20 volumio volumio[1012]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 05 15:57:20 volumio volumio[1012]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseTrackInfo Sep 05 15:57:20 volumio volumio[1012]: verbose: ControllerMpd::parseTrackInfo Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::pushState Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::pushState Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::pushState Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Sep 05 15:57:20 volumio volumio[1012]: info: ControllerMpd::pushState Sep 05 15:57:20 volumio volumio[1012]: info: CoreCommandRouter::servicePushState Sep 05 15:57:20 volumio volumio[1012]: info: CorePlayQueue::getTrack 0 Sep 05 15:57:20 volumio volumio[1012]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Sep 05 15:57:20 volumio volumio[1012]: info: ------------------------------ 18ms Sep 05 15:57:20 volumio volumio[1012]: info: ------------------------------ 12ms Sep 05 15:57:20 volumio volumio[1012]: info: ------------------------------ 11ms Sep 05 15:57:20 volumio volumio[1012]: info: FusionDsp - Effects disabled Sep 05 15:57:21 volumio volumio[1012]: info: FusionDsp - Sep 05 15:57:21 volumio volumio[1012]: error: FusionDsp - WebSocket error: [object Object] Sep 05 15:57:32 volumio volumio[1012]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/13th%20Floor%20Elevators/Nuggets%3A%20Original%20Artyfacts%20From%20The%20First%20Psychedelic%20Era%201965-1968%20(Disc%201)/a711562c-5d7f-486e-bbcc-26c77b194381.jpg' Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 15:57:47 volumio volumio[1012]: info: Received Get System Version Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 15:57:47 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Sep 05 15:58:22 volumio volumio[1012]: Uploading: thumbnail-berlin.jpg Sep 05 15:58:22 volumio volumio[1012]: Background Successfully Uploaded Sep 05 15:58:22 volumio volumio[1012]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Sep 05 15:58:22 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , generateThumbnails Sep 05 15:58:22 volumio volumio[1012]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Sep 05 15:58:22 volumio volumio[1012]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 15:58:22 volumio volumio[1012]: Error: connect ETIMEDOUT 146.75.118.79:443 Sep 05 15:58:22 volumio volumio[1012]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 05 15:58:22 volumio volumio[1012]: errno: -110, Sep 05 15:58:22 volumio volumio[1012]: code: 'ETIMEDOUT', Sep 05 15:58:22 volumio volumio[1012]: syscall: 'connect', Sep 05 15:58:22 volumio volumio[1012]: address: '146.75.118.79', Sep 05 15:58:22 volumio volumio[1012]: port: 443 Sep 05 15:58:22 volumio volumio[1012]: } Sep 05 15:58:22 volumio volumio[1012]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 15:58:22 volumio sudo[9284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-05 15:57 Sep 05 15:58:22 volumio sudo[9284]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"