-- Logs begin at Thu 2022-06-09 16:00:54 UTC, end at Thu 2022-06-09 16:16:35 UTC. -- Jun 09 16:15:02 volumio ntpd[546]: Soliciting pool server 132.248.3.29 Jun 09 16:15:03 volumio sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 16:15:03 volumio sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:15:03 volumio sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 16:15:03 volumio sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:15:03 volumio sudo[1492]: pam_unix(sudo:session): session closed for user root Jun 09 16:15:03 volumio sudo[1490]: pam_unix(sudo:session): session closed for user root Jun 09 16:15:04 volumio volumio[605]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/15.6.1 Safari/605.1.15 Total Clients: 17 Jun 09 16:15:05 volumio sudo[1498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 16:15:05 volumio sudo[1498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:15:06 volumio sudo[1500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 16:15:06 volumio sudo[1500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 16:15:06 volumio sudo[1500]: pam_unix(sudo:session): session closed for user root Jun 09 16:15:06 volumio sudo[1498]: pam_unix(sudo:session): session closed for user root Jun 09 16:15:06 volumio volumio[605]: verbose: New Socket.io Connection to 192.168.0.6 from 192.168.0.28 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/15.6.1 Safari/605.1.15 Total Clients: 18 Jun 09 16:15:07 volumio ntpd[546]: Soliciting pool server 132.248.3.29 Jun 09 16:15:07 volumio ntpd[546]: Soliciting pool server 45.183.178.129 Jun 09 16:15:10 volumio volumio[605]: info: CoreCommandRouter::volumioGetState Jun 09 16:15:10 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:15:25 volumio systemd[1]: Starting Cleanup of Temporary Directories... Jun 09 16:15:26 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Jun 09 16:15:26 volumio systemd[1]: Started Cleanup of Temporary Directories. Jun 09 16:15:35 volumio ntpd[546]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 09 16:15:58 volumio ntpd[546]: Soliciting pool server 45.231.168.6 Jun 09 16:15:58 volumio ntpd[546]: Soliciting pool server 45.134.9.253 Jun 09 16:16:04 volumio ntpd[546]: Soliciting pool server 45.231.168.6 Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::volumioGetVisibleSources Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 09 16:16:04 volumio volumio[605]: info: Listing playlists Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 09 16:16:04 volumio volumio[605]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 09 16:16:04 volumio volumio[605]: info: Received Get System Version Jun 09 16:16:04 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 09 16:16:06 volumio ntpd[546]: Soliciting pool server 2001:19f0:b400:2ffd:5400:5ff:fe63:33ba Jun 09 16:16:12 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 09 16:16:13 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 09 16:16:27 volumio volumio[605]: info: Airplay started streaming, receiving metadatas Jun 09 16:16:27 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:27 volumio volumio[605]: info: CoreCommandRouter::volumioStop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::stop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: verbose: UNSET VOLATILE Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: info: Airplay started streaming, receiving metadatas Jun 09 16:16:27 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:27 volumio volumio[605]: info: CoreCommandRouter::volumioStop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::stop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: verbose: UNSET VOLATILE Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: info: Airplay started streaming, receiving metadatas Jun 09 16:16:27 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:27 volumio volumio[605]: info: CoreCommandRouter::volumioStop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::stop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: verbose: UNSET VOLATILE Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: info: Airplay started streaming, receiving metadatas Jun 09 16:16:27 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:27 volumio volumio[605]: info: CoreCommandRouter::volumioStop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::stop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: verbose: UNSET VOLATILE Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: info: Airplay started streaming, receiving metadatas Jun 09 16:16:27 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:27 volumio volumio[605]: info: CoreCommandRouter::volumioStop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::stop Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:27 volumio volumio[605]: verbose: UNSET VOLATILE Jun 09 16:16:27 volumio volumio[605]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus stop Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:28 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio shairport-sync[1238]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 09 16:16:28 volumio shairport-sync[1238]: Dload Upload Total Spent Left Speed Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:28 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:28 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:28 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:28 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:28 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:28 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":136000,"duration":148,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:28 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:28 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:28 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":136000,"duration":148,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:29 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:29 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":136000,"duration":148,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:29 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:29 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":136000,"duration":148,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:29 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:29 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Té Para Tres","artist":"Soda Stereo","album":"Canción Animal","albumart":"/albumart?cacheid=792&web=Soda%20Stereo/Canci%C3%B3n%20Animal/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":136000,"duration":148,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true} Jun 09 16:16:29 volumio volumio[605]: verbose: CURRENT POSITION 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState stateService play Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:16:29 volumio volumio[605]: info: Received an update from plugin. extracting info from payload Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CorePlayQueue::getTrack 0 Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::servicePushState Jun 09 16:16:29 volumio volumio[605]: info: CoreStateMachine::pushState Jun 09 16:16:29 volumio volumio[605]: info: CoreCommandRouter::volumioPushState Jun 09 16:16:30 volumio volumio[605]: info: Jun 09 16:16:30 volumio volumio[605]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jun 09 16:16:30 volumio volumio[605]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jun 09 16:16:30 volumio volumio[605]: info: Airplay playback start Jun 09 16:16:30 volumio shairport-sync[1238]: [316B blob data] Jun 09 16:16:31 volumio volumio[605]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:16:31 volumio volumio[605]: Error: certificate is not yet valid Jun 09 16:16:31 volumio volumio[605]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Jun 09 16:16:31 volumio volumio[605]: at TLSSocket.emit (events.js:315:20) Jun 09 16:16:31 volumio volumio[605]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Jun 09 16:16:31 volumio volumio[605]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Jun 09 16:16:31 volumio volumio[605]: code: 'CERT_NOT_YET_VALID' Jun 09 16:16:31 volumio volumio[605]: } Jun 09 16:16:31 volumio volumio[605]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:16:35 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2022-06-09 16:15 Jun 09 16:16:35 volumio sudo[1540]: 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="3cfa1502993c2310fc263d6ebda1707071fe4cc2" VOLUMIO_FE_VERSION="8efe4f08f83e5de574651b8ed2333629c140d365" VOLUMIO_FE3_VERSION="8f1d07fcde806ea34f52cff908ec76359e14970e" VOLUMIO_BE_VERSION="e249dfa388452e6b8443121dc9b4cabca459c531" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 09 Jun 2022 05:55:51 PM CEST" VOLUMIO_VERSION="3.301" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6a8974e587cd4bab189d231f79b65462"