-- Logs begin at Tue 2023-05-23 15:22:30 UTC, end at Tue 2023-05-23 15:26:16 UTC. --
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true}
May 23 15:25:20 volumio2 volumio[989]: verbose: CURRENT POSITION 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::syncState stateService play
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::syncState currentStatus stop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true}
May 23 15:25:20 volumio2 volumio[989]: verbose: CURRENT POSITION 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::syncState stateService play
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::syncState currentStatus play
May 23 15:25:20 volumio2 volumio[989]: info: Received an update from plugin. extracting info from payload
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:20 volumio2 shairport-sync[1276]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:20 volumio2 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
May 23 15:25:20 volumio2 shairport-sync[1276]: % Total % Received % Xferd Average Speed Time Time Time Current
May 23 15:25:20 volumio2 shairport-sync[1276]: Dload Upload Total Spent Left Speed
May 23 15:25:20 volumio2 volumio[989]: info: Airplay started streaming, receiving metadatas
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioStop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::stop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 shairport-sync[1276]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current
May 23 15:25:20 volumio2 shairport-sync[1276]: Dload Upload Total Spent Left Speed
May 23 15:25:20 volumio2 volumio[989]: verbose: UNSET VOLATILE
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::stPlaybackTimer
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::updateTrackBlock
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrackBlock
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::serviceStop
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: ControllerMpd::stop
May 23 15:25:20 volumio2 volumio[989]: verbose: ControllerMpd::sendMpdCommand stop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 volumio[989]: info: Airplay started streaming, receiving metadatas
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioStop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::stop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 volumio[989]: verbose: UNSET VOLATILE
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
May 23 15:25:20 volumio2 volumio[989]: info: sendMpdCommand stop took 45 milliseconds
May 23 15:25:20 volumio2 volumio[989]: info:
May 23 15:25:20 volumio2 volumio[989]: ---------------------------- Client requests AirplayActive
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive
May 23 15:25:20 volumio2 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
May 23 15:25:20 volumio2 shairport-sync[1276]: [234B blob data]
May 23 15:25:20 volumio2 volumio[989]: info:
May 23 15:25:20 volumio2 volumio[989]: ---------------------------- Client requests Start Airplay PlaybackRoutine
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
May 23 15:25:20 volumio2 volumio[989]: info: Airplay playback start
May 23 15:25:20 volumio2 volumio[989]: info: CorePlayQueue::getTrack 0
May 23 15:25:20 volumio2 volumio[989]: info: CoreCommandRouter::volumioStop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::stop
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 volumio[989]: verbose: UNSET VOLATILE
May 23 15:25:20 volumio2 volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 15:25:20 volumio2 shairport-sync[1276]: [136B blob data]
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:21 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::servicePushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreStateMachine::pushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::volumioPushState
May 23 15:25:22 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 23 15:26:13 volumio2 volumio[989]: info: Discovery: Getting this device information
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::volumioGetState
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConf
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConf
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::volumioGetState
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 23 15:26:13 volumio2 volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 23 15:26:14 volumio2 volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 15:26:14 volumio2 volumio[989]: { Error: certificate is not yet valid
May 23 15:26:14 volumio2 volumio[989]: at TLSSocket. (_tls_wrap.js:1105:38)
May 23 15:26:14 volumio2 volumio[989]: at emitNone (events.js:106:13)
May 23 15:26:14 volumio2 volumio[989]: at TLSSocket.emit (events.js:208:7)
May 23 15:26:14 volumio2 volumio[989]: at TLSSocket._finishInit (_tls_wrap.js:639:8)
May 23 15:26:14 volumio2 volumio[989]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:469:38) code: 'CERT_NOT_YET_VALID' }
May 23 15:26:14 volumio2 volumio[989]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 15:26:16 volumio2 sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-05-23 15:25
May 23 15:26:16 volumio2 sudo[1698]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"