-- Logs begin at Thu 2024-10-17 04:42:57 UTC, end at Thu 2024-10-17 04:45:46 UTC. -- Oct 17 04:44:16 volumio ntpd[1042]: Soliciting pool server 193.182.111.12 Oct 17 04:44:20 volumio ntpd[1042]: Soliciting pool server 84.16.73.33 Oct 17 04:44:21 volumio ntpd[1042]: Soliciting pool server 119.28.183.184 Oct 17 04:44:23 volumio ntpd[1042]: Soliciting pool server 84.16.67.12 Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:25 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:25 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:25 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:25 volumio shairport-sync[1291]: {"time":1729140207451,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 17 04:44:25 volumio shairport-sync[1291]: Dload Upload Total Spent Left Speed Oct 17 04:44:25 volumio volumio[539]: info: Oct 17 04:44:25 volumio volumio[539]: ---------------------------- Client requests Stop Airplay Playback Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Oct 17 04:44:25 volumio volumio[539]: info: Airplay playback stop Oct 17 04:44:25 volumio volumio[539]: info: Airplay Playback Stopped, clearing state Oct 17 04:44:25 volumio volumio[539]: info: CoreStateMachine::resetVolumioState Oct 17 04:44:25 volumio volumio[539]: info: CoreStateMachine::getcurrentVolume Oct 17 04:44:25 volumio volumio[539]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 04:44:26 volumio shairport-sync[1291]: [158B blob data] Oct 17 04:44:26 volumio volumio[539]: info: VolumeController:: Volume=100 Mute =false Oct 17 04:44:26 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:26 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:26 volumio volumio[539]: info: CoreStateMachine::updateTrackBlock Oct 17 04:44:26 volumio volumio[539]: info: CorePlayQueue::getTrackBlock Oct 17 04:44:26 volumio volumio[539]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 04:44:26 volumio volumio[539]: info: VolumeController:: Volume=100 Mute =false Oct 17 04:44:26 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:26 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:32 volumio volumio[539]: info: Airplay started streaming, receiving metadatas Oct 17 04:44:32 volumio shairport-sync[1291]: {"time":1729140265984,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 17 04:44:32 volumio shairport-sync[1291]: Dload Upload Total Spent Left Speed Oct 17 04:44:32 volumio volumio[539]: info: Oct 17 04:44:32 volumio volumio[539]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 17 04:44:32 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 17 04:44:32 volumio volumio[539]: info: Airplay playback start Oct 17 04:44:32 volumio shairport-sync[1291]: [158B blob data] Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:33 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:33 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:33 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:33 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:33 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:34 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:34 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:42 volumio shairport-sync[1291]: {"time":1729140272683,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 17 04:44:42 volumio shairport-sync[1291]: Dload Upload Total Spent Left Speed Oct 17 04:44:42 volumio volumio[539]: info: Oct 17 04:44:42 volumio volumio[539]: ---------------------------- Client requests Stop Airplay Playback Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Oct 17 04:44:42 volumio volumio[539]: info: Airplay playback stop Oct 17 04:44:42 volumio volumio[539]: info: Airplay Playback Stopped, clearing state Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::resetVolumioState Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::getcurrentVolume Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 04:44:42 volumio shairport-sync[1291]: [158B blob data] Oct 17 04:44:42 volumio volumio[539]: info: VolumeController:: Volume=100 Mute =false Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::updateTrackBlock Oct 17 04:44:42 volumio volumio[539]: info: CorePlayQueue::getTrackBlock Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 04:44:42 volumio volumio[539]: info: VolumeController:: Volume=100 Mute =false Oct 17 04:44:42 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:42 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:45 volumio volumio[539]: info: Airplay started streaming, receiving metadatas Oct 17 04:44:45 volumio shairport-sync[1291]: {"time":1729140282266,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 17 04:44:45 volumio shairport-sync[1291]: Dload Upload Total Spent Left Speed Oct 17 04:44:45 volumio volumio[539]: info: Oct 17 04:44:45 volumio volumio[539]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 17 04:44:45 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 17 04:44:45 volumio volumio[539]: info: Airplay playback start Oct 17 04:44:45 volumio shairport-sync[1291]: [158B blob data] Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:46 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:46 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:46 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:46 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:46 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::servicePushState Oct 17 04:44:47 volumio volumio[539]: info: CoreStateMachine::pushState Oct 17 04:44:47 volumio volumio[539]: info: CoreCommandRouter::volumioPushState Oct 17 04:45:21 volumio ntpd[1042]: Soliciting pool server 193.182.111.142 Oct 17 04:45:24 volumio ntpd[1042]: Soliciting pool server 193.182.111.143 Oct 17 04:45:28 volumio ntpd[1042]: Soliciting pool server 193.182.111.141 Oct 17 04:45:30 volumio ntpd[1042]: Soliciting pool server 78.46.102.180 Oct 17 04:45:31 volumio ntpd[1042]: Soliciting pool server 2a03:8600::aa Oct 17 04:45:46 volumio volumio[539]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 04:45:46 volumio volumio[539]: Error: connect ETIMEDOUT 23.234.30.58:443 Oct 17 04:45:46 volumio volumio[539]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 17 04:45:46 volumio volumio[539]: errno: -110, Oct 17 04:45:46 volumio volumio[539]: code: 'ETIMEDOUT', Oct 17 04:45:46 volumio volumio[539]: syscall: 'connect', Oct 17 04:45:46 volumio volumio[539]: address: '23.234.30.58', Oct 17 04:45:46 volumio volumio[539]: port: 443 Oct 17 04:45:46 volumio volumio[539]: } Oct 17 04:45:46 volumio volumio[539]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 04:45:46 volumio sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 04:44 Oct 17 04:45:46 volumio sudo[1687]: 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"