-- Logs begin at Thu 2020-09-24 20:56:34 UTC, end at Fri 2020-09-25 20:25:44 UTC. -- Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 25 20:24:41 volumio-mosa volumio[1021]: info: Discovery: Getting this device information Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioGetState Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConf Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConf Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioGetState Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 25 20:24:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 25 20:24:43 volumio-mosa sudo[4064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 25 20:24:43 volumio-mosa sudo[4064]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 25 20:24:43 volumio-mosa sudo[4064]: pam_unix(sudo:session): session closed for user root Sep 25 20:24:43 volumio-mosa sudo[4070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 25 20:24:43 volumio-mosa sudo[4070]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 25 20:24:43 volumio-mosa sudo[4070]: pam_unix(sudo:session): session closed for user root Sep 25 20:24:43 volumio-mosa sudo[4083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 25 20:24:43 volumio-mosa sudo[4083]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 25 20:24:43 volumio-mosa sudo[4083]: pam_unix(sudo:session): session closed for user root Sep 25 20:24:43 volumio-mosa sudo[4088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 25 20:24:43 volumio-mosa sudo[4088]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 25 20:24:43 volumio-mosa sudo[4088]: pam_unix(sudo:session): session closed for user root Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioGetState Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 25 20:24:43 volumio-mosa volumio[1021]: info: Listing playlists Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 25 20:24:43 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 25 20:25:20 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:20 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:20 volumio-mosa volumio[1021]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Sep 25 20:25:20 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:20 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:20 volumio-mosa volumio[1021]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Airplay started streaming, receiving metadatas Sep 25 20:25:21 volumio-mosa kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioStop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa volumio[1021]: UNSET VOLATILE Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::updateTrackBlock Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrackBlock Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::stPlaybackTimer Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::serviceStop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::serviceStop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: ControllerMpd::stop Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Airplay started streaming, receiving metadatas Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioStop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa volumio[1021]: UNSET VOLATILE Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: Dload Upload Total Spent Left Speed Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: Dload Upload Total Spent Left Speed Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Sep 25 20:25:21 volumio-mosa volumio[1021]: ---------------------------- MPD announces state update: player Sep 25 20:25:21 volumio-mosa volumio[1021]: info: ControllerMpd::getState Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: ControllerMpd::parseState Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: ControllerMpd::parseTrackInfo Sep 25 20:25:21 volumio-mosa volumio[1021]: info: ControllerMpd::pushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A Whiter Shade Of Pale","artist":"Sarah Brightman","album":"Voices 3 美聲殿堂","uri":"USB/新加卷/AIFF 2.6T/3.Pop/Voices 3 美聲殿堂/03 A Whiter Shade Of Pale.aif","trackType":"aif"} Sep 25 20:25:21 volumio-mosa volumio[1021]: verbose: CURRENT POSITION 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::syncState stateService stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:21 volumio-mosa volumio[1021]: info: No code Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:21 volumio-mosa volumio[1021]: info: ------------------------------ 26ms Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Sep 25 20:25:21 volumio-mosa volumio[1021]: ---------------------------- Client requests Start Airplay PlaybackRoutine Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Airplay playback start Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CorePlayQueue::getTrack 2 Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioStop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::stop Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa volumio[1021]: UNSET VOLATILE Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: [155B blob data] Sep 25 20:25:21 volumio-mosa volumio[1021]: info: Sep 25 20:25:21 volumio-mosa volumio[1021]: ---------------------------- Client requests AirplayActive Sep 25 20:25:21 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Sep 25 20:25:21 volumio-mosa shairport-sync[1210]: [143B blob data] Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::servicePushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreStateMachine::pushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioPushState Sep 25 20:25:22 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 25 20:25:41 volumio-mosa volumio[1021]: info: Discovery: Getting this device information Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioGetState Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConf Sep 25 20:25:41 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConf Sep 25 20:25:42 volumio-mosa volumio[1021]: info: CoreCommandRouter::volumioGetState Sep 25 20:25:42 volumio-mosa volumio[1021]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 25 20:25:42 volumio-mosa volumio[1021]: info: Listing playlists Sep 25 20:25:43 volumio-mosa volumio[1021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 25 20:25:43 volumio-mosa volumio[1021]: { Error: certificate is not yet valid Sep 25 20:25:43 volumio-mosa volumio[1021]: at TLSSocket. (_tls_wrap.js:1105:38) Sep 25 20:25:43 volumio-mosa volumio[1021]: at emitNone (events.js:106:13) Sep 25 20:25:43 volumio-mosa volumio[1021]: at TLSSocket.emit (events.js:208:7) Sep 25 20:25:43 volumio-mosa volumio[1021]: at TLSSocket._finishInit (_tls_wrap.js:639:8) Sep 25 20:25:43 volumio-mosa volumio[1021]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:469:38) code: 'CERT_NOT_YET_VALID' } Sep 25 20:25:43 volumio-mosa volumio[1021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 25 20:25:44 volumio-mosa sudo[4267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2020-09-25 20:24 Sep 25 20:25:44 volumio-mosa sudo[4267]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"