-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Wed 2024-06-26 09:05:34 EDT. -- Jun 26 09:04:00 excelsior-1032 ntpd[783]: Soliciting pool server 204.2.134.173 Jun 26 09:04:01 excelsior-1032 volumiologrotate[650]: ls: cannot access '/var/log/samba/log.wb-EXCELSIOR': No such file or directory Jun 26 09:04:01 excelsior-1032 volumiologrotate[650]: ls: cannot access '1032': No such file or directory Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:01 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:02 excelsior-1032 ntpd[783]: Soliciting pool server 45.63.54.13 Jun 26 09:04:04 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:08 excelsior-1032 shairport-sync[1290]: {"time":1719407035421,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jun 26 09:04:08 excelsior-1032 shairport-sync[1290]: Dload Upload Total Spent Left Speed Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: Jun 26 09:04:08 excelsior-1032 volumio[1047]: ---------------------------- Client requests Stop Airplay Playback Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: Airplay playback stop Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: Airplay Playback Stopped, clearing state Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::resetVolumioState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::getcurrentVolume Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioRetrievevolume Jun 26 09:04:08 excelsior-1032 shairport-sync[1290]: [158B blob data] Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:04:08 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:04:12 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:19 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:27 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:35 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:43 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:50 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:04:58 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:05:01 excelsior-1032 ntpd[783]: Soliciting pool server 199.101.96.52 Jun 26 09:05:02 excelsior-1032 volumiologrotate[650]: ls: cannot access '/var/log/samba/log.wb-EXCELSIOR': No such file or directory Jun 26 09:05:02 excelsior-1032 volumiologrotate[650]: ls: cannot access '1032': No such file or directory Jun 26 09:05:05 excelsior-1032 ntpd[783]: Soliciting pool server 198.46.254.130 Jun 26 09:05:06 excelsior-1032 ntpd[783]: Soliciting pool server 193.29.63.226 Jun 26 09:05:06 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:05:07 excelsior-1032 ntpd[783]: Soliciting pool server 208.113.130.146 Jun 26 09:05:14 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:05:22 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:05:22 excelsior-1032 volumio[1047]: info: Airplay started streaming, receiving metadatas Jun 26 09:05:22 excelsior-1032 shairport-sync[1290]: {"time":1719407048861,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jun 26 09:05:22 excelsior-1032 shairport-sync[1290]: Dload Upload Total Spent Left Speed Jun 26 09:05:22 excelsior-1032 volumio[1047]: info: Jun 26 09:05:22 excelsior-1032 volumio[1047]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jun 26 09:05:22 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jun 26 09:05:22 excelsior-1032 volumio[1047]: info: Airplay playback start Jun 26 09:05:22 excelsior-1032 shairport-sync[1290]: [158B blob data] Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:23 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::servicePushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreStateMachine::pushState Jun 26 09:05:24 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioPushState Jun 26 09:05:29 excelsior-1032 wpa_supplicant[892]: wlan0: Failed to initiate sched scan Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: Discovery: Getting this device information Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetState Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: Discovery: Getting this device information Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetState Jun 26 09:05:33 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 09:05:34 excelsior-1032 volumio[1047]: verbose: New Socket.io Connection to 10.40.40.105 from 10.40.40.19 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetState Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: Received Get System Info Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: Discovery: Getting this device information Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetState Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: CoreCommandRouter::volumioGetState Jun 26 09:05:34 excelsior-1032 volumio[1047]: info: Listing playlists Jun 26 09:05:34 excelsior-1032 volumio[1047]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 09:05:34 excelsior-1032 volumio[1047]: Error: certificate is not yet valid Jun 26 09:05:34 excelsior-1032 volumio[1047]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Jun 26 09:05:34 excelsior-1032 volumio[1047]: at TLSSocket.emit (events.js:315:20) Jun 26 09:05:34 excelsior-1032 volumio[1047]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Jun 26 09:05:34 excelsior-1032 volumio[1047]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Jun 26 09:05:34 excelsior-1032 volumio[1047]: code: 'CERT_NOT_YET_VALID' Jun 26 09:05:34 excelsior-1032 volumio[1047]: } Jun 26 09:05:34 excelsior-1032 volumio[1047]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 09:05:34 excelsior-1032 sudo[2003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-06-26 09:04 Jun 26 09:05:34 excelsior-1032 sudo[2003]: 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="56f667f35bc4c5b76d503220e3fbd9ea429172ba" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="218f986668198768ef5630191ffb17431779722f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="fleetwood" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 26 Jun 2024 02:46:53 PM CEST" VOLUMIO_VERSION="3.685" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_VENDOR_MODEL="Fleetwood Excelsior" VOLUMIO_VENDOR="Fleetwood" VOLUMIO_MODEL="Excelsior" VOLUMIO_HASH="192754d8bc6399dafb355ad05b577862"