-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Tue 2024-09-17 23:24:40 CST. -- Sep 17 23:23:00 volumio volumio[2859]: 45 Sep 17 23:23:00 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:00 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:00 volumio volumio[886]: info: Sep 17 23:23:00 volumio volumio[886]: ---------------------------- Client requests Volume 45 Sep 17 23:23:00 volumio volumio[886]: info: VolumeController::SetAlsaVolume45 Sep 17 23:23:00 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:00 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:00 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:00 volumio volumio[2859]: [158B blob data] Sep 17 23:23:00 volumio volumio[2859]: {"time":1726586580854,"response":"volume Success"}45 Sep 17 23:23:00 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:00 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:00 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:01 volumio ntpd[795]: Soliciting pool server 193.182.111.141 Sep 17 23:23:01 volumio volumio[2859]: 40 Sep 17 23:23:01 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:01 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:01 volumio volumio[886]: info: Sep 17 23:23:01 volumio volumio[886]: ---------------------------- Client requests Volume 40 Sep 17 23:23:01 volumio volumio[886]: info: VolumeController::SetAlsaVolume40 Sep 17 23:23:01 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:01 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:01 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:01 volumio volumio[2859]: [237B blob data] Sep 17 23:23:01 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:01 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:01 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:01 volumio volumio[2859]: {"time":1726586581516,"response":"volume Success"}40 Sep 17 23:23:02 volumio volumio[2859]: 35 Sep 17 23:23:02 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:02 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:02 volumio volumio[886]: info: Sep 17 23:23:02 volumio volumio[886]: ---------------------------- Client requests Volume 35 Sep 17 23:23:02 volumio volumio[886]: info: VolumeController::SetAlsaVolume35 Sep 17 23:23:02 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:02 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:02 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:02 volumio volumio[2859]: [158B blob data] Sep 17 23:23:02 volumio volumio[2859]: {"time":1726586582665,"response":"volume Success"}35 Sep 17 23:23:02 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:02 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:02 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:03 volumio volumio[2859]: 30 Sep 17 23:23:03 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:03 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:03 volumio volumio[886]: info: Sep 17 23:23:03 volumio volumio[886]: ---------------------------- Client requests Volume 30 Sep 17 23:23:03 volumio volumio[886]: info: VolumeController::SetAlsaVolume30 Sep 17 23:23:03 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:03 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:03 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:03 volumio volumio[2859]: [158B blob data] Sep 17 23:23:03 volumio volumio[2859]: {"time":1726586583954,"response":"volume Success"}30 Sep 17 23:23:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:03 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:03 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:04 volumio volumio[2859]: 25 Sep 17 23:23:04 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:04 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:04 volumio volumio[886]: info: Sep 17 23:23:04 volumio volumio[886]: ---------------------------- Client requests Volume 25 Sep 17 23:23:04 volumio volumio[886]: info: VolumeController::SetAlsaVolume25 Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:04 volumio volumio[2859]: [158B blob data] Sep 17 23:23:04 volumio volumio[2859]: {"time":1726586584091,"response":"volume Success"}25 Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:04 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:04 volumio volumio[2859]: 30 Sep 17 23:23:04 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:04 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:04 volumio volumio[886]: info: Sep 17 23:23:04 volumio volumio[886]: ---------------------------- Client requests Volume 30 Sep 17 23:23:04 volumio volumio[886]: info: VolumeController::SetAlsaVolume30 Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:04 volumio volumio[2859]: [158B blob data] Sep 17 23:23:04 volumio volumio[2859]: {"time":1726586584281,"response":"volume Success"}30 Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:04 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:04 volumio volumio[2859]: 35 Sep 17 23:23:04 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:04 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:04 volumio volumio[886]: info: Sep 17 23:23:04 volumio volumio[886]: ---------------------------- Client requests Volume 35 Sep 17 23:23:04 volumio volumio[886]: info: VolumeController::SetAlsaVolume35 Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:04 volumio volumio[2859]: [158B blob data] Sep 17 23:23:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:04 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:04 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:04 volumio volumio[2859]: {"time":1726586584864,"response":"volume Success"}35 Sep 17 23:23:04 volumio volumio[2859]: 40 Sep 17 23:23:05 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:05 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:05 volumio volumio[886]: info: Sep 17 23:23:05 volumio volumio[886]: ---------------------------- Client requests Volume 40 Sep 17 23:23:05 volumio volumio[886]: info: VolumeController::SetAlsaVolume40 Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:05 volumio volumio[2859]: [158B blob data] Sep 17 23:23:05 volumio volumio[2859]: {"time":1726586585004,"response":"volume Success"}40 Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:05 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:05 volumio volumio[2859]: 45 Sep 17 23:23:05 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:05 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:05 volumio volumio[886]: info: Sep 17 23:23:05 volumio volumio[886]: ---------------------------- Client requests Volume 45 Sep 17 23:23:05 volumio volumio[886]: info: VolumeController::SetAlsaVolume45 Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:05 volumio volumio[2859]: [158B blob data] Sep 17 23:23:05 volumio volumio[2859]: {"time":1726586585289,"response":"volume Success"}45 Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:05 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:05 volumio volumio[2859]: 50 Sep 17 23:23:05 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:05 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:05 volumio volumio[886]: info: Sep 17 23:23:05 volumio volumio[886]: ---------------------------- Client requests Volume 50 Sep 17 23:23:05 volumio volumio[886]: info: VolumeController::SetAlsaVolume50 Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:05 volumio volumio[2859]: [158B blob data] Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:05 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:05 volumio volumio[2859]: {"time":1726586585579,"response":"volume Success"}50 Sep 17 23:23:05 volumio volumio[2859]: 55 Sep 17 23:23:05 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:05 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:05 volumio volumio[886]: info: Sep 17 23:23:05 volumio volumio[886]: ---------------------------- Client requests Volume 55 Sep 17 23:23:05 volumio volumio[886]: info: VolumeController::SetAlsaVolume55 Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:05 volumio volumio[2859]: [158B blob data] Sep 17 23:23:05 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:05 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:05 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:05 volumio volumio[2859]: {"time":1726586585900,"response":"volume Success"}55 Sep 17 23:23:06 volumio volumio[2859]: 60 Sep 17 23:23:06 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:06 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:06 volumio volumio[886]: info: Sep 17 23:23:06 volumio volumio[886]: ---------------------------- Client requests Volume 60 Sep 17 23:23:06 volumio volumio[886]: info: VolumeController::SetAlsaVolume60 Sep 17 23:23:06 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:06 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:06 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:06 volumio volumio[2859]: [158B blob data] Sep 17 23:23:06 volumio volumio[2859]: {"time":1726586586221,"response":"volume Success"}60 Sep 17 23:23:06 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:06 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:06 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:07 volumio volumio[2859]: 55 Sep 17 23:23:07 volumio volumio[2859]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 17 23:23:07 volumio volumio[2859]: Dload Upload Total Spent Left Speed Sep 17 23:23:07 volumio volumio[886]: info: Sep 17 23:23:07 volumio volumio[886]: ---------------------------- Client requests Volume 55 Sep 17 23:23:07 volumio volumio[886]: info: VolumeController::SetAlsaVolume55 Sep 17 23:23:07 volumio volumio[886]: info: CoreStateMachine::pushState Sep 17 23:23:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 23:23:07 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Sep 17 23:23:07 volumio volumio[2859]: [158B blob data] Sep 17 23:23:07 volumio volumio[2859]: {"time":1726586587121,"response":"volume Success"}55 Sep 17 23:23:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:23:07 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:23:07 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:23:36 volumio ntpd[795]: Soliciting pool server 162.159.200.1 Sep 17 23:23:42 volumio ntpd[795]: Soliciting pool server 2001:da8:215:4020::118:123 Sep 17 23:23:46 volumio ntpd[795]: Soliciting pool server 193.182.111.142 Sep 17 23:23:47 volumio ntpd[795]: Soliciting pool server 202.118.1.81 Sep 17 23:24:36 volumio ntpd[795]: Soliciting pool server 202.112.29.82 Sep 17 23:24:37 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.123.247 from 192.168.123.180 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/122.0.6261.95 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetVisibleSources Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 17 23:24:37 volumio volumio[886]: info: Received Get System Info Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 23:24:37 volumio volumio[886]: info: Discovery: Getting this device information Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Sep 17 23:24:37 volumio volumio[886]: info: Listing playlists Sep 17 23:24:37 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Sep 17 23:24:37 volumio volumio[886]: info: CoreStateMachine::getQueue Sep 17 23:24:37 volumio volumio[886]: info: CorePlayQueue::getQueue Sep 17 23:24:39 volumio volumio[886]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 23:24:39 volumio volumio[886]: Error: connect ETIMEDOUT 157.240.10.41:443 Sep 17 23:24:39 volumio volumio[886]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 17 23:24:39 volumio volumio[886]: errno: -110, Sep 17 23:24:39 volumio volumio[886]: code: 'ETIMEDOUT', Sep 17 23:24:39 volumio volumio[886]: syscall: 'connect', Sep 17 23:24:39 volumio volumio[886]: address: '157.240.10.41', Sep 17 23:24:39 volumio volumio[886]: port: 443 Sep 17 23:24:39 volumio volumio[886]: } Sep 17 23:24:39 volumio volumio[886]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 23:24:40 volumio sudo[3800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-17 23:23 Sep 17 23:24:40 volumio sudo[3800]: 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"