-- Logs begin at Thu 2019-02-14 18:11:59 HKT, end at Wed 2025-09-17 17:33:42 HKT. --
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:14 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:34 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:35 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:36 volumio shairport-sync[9331]: {"time":1758101491682,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
Sep 17 17:32:36 volumio shairport-sync[9331]: Dload Upload Total Spent Left Speed
Sep 17 17:32:36 volumio volumio[9181]: info:
Sep 17 17:32:36 volumio volumio[9181]: ---------------------------- Client requests Stop Airplay Playback
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
Sep 17 17:32:36 volumio volumio[9181]: info: Airplay playback stop
Sep 17 17:32:36 volumio volumio[9181]: info: Airplay Playback Stopped, clearing state
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::resetVolumioState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::getcurrentVolume
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 17:32:36 volumio shairport-sync[9331]: [158B blob data]
Sep 17 17:32:36 volumio volumio[9181]: info: VolumeController:: Volume=100 Mute =false
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::updateTrackBlock
Sep 17 17:32:36 volumio volumio[9181]: info: CorePlayQueue::getTrackBlock
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 17:32:36 volumio volumio[9181]: info: VolumeController:: Volume=100 Mute =false
Sep 17 17:32:36 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:36 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:56 volumio kernel: hwmon hwmon1: Voltage normalised
Sep 17 17:32:56 volumio volumio[9181]: info: Airplay started streaming, receiving metadatas
Sep 17 17:32:56 volumio volumio[9181]: info: Airplay started streaming, receiving metadatas
Sep 17 17:32:56 volumio shairport-sync[9331]: {"time":1758101556210,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
Sep 17 17:32:56 volumio shairport-sync[9331]: Dload Upload Total Spent Left Speed
Sep 17 17:32:56 volumio volumio[9181]: info:
Sep 17 17:32:56 volumio volumio[9181]: ---------------------------- Client requests Start Airplay PlaybackRoutine
Sep 17 17:32:56 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
Sep 17 17:32:56 volumio volumio[9181]: info: Airplay playback start
Sep 17 17:32:56 volumio shairport-sync[9331]: [158B blob data]
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:57 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio kernel: hwmon hwmon1: Undervoltage detected!
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:32:58 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::servicePushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreStateMachine::pushState
Sep 17 17:33:29 volumio volumio[9181]: info: CoreCommandRouter::volumioPushState
Sep 17 17:33:41 volumio volumio[9181]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 17:33:41 volumio volumio[9181]: Error: connect ETIMEDOUT 104.244.46.21:443
Sep 17 17:33:41 volumio volumio[9181]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Sep 17 17:33:41 volumio volumio[9181]: errno: -110,
Sep 17 17:33:41 volumio volumio[9181]: code: 'ETIMEDOUT',
Sep 17 17:33:41 volumio volumio[9181]: syscall: 'connect',
Sep 17 17:33:41 volumio volumio[9181]: address: '104.244.46.21',
Sep 17 17:33:41 volumio volumio[9181]: port: 443
Sep 17 17:33:41 volumio volumio[9181]: }
Sep 17 17:33:41 volumio volumio[9181]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 17:33:42 volumio sudo[9666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 17:32
Sep 17 17:33:42 volumio sudo[9666]: 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="9552505bba4239c163ac9ee7b0b87a56e0dd0574"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 06:28:23 PM CET"
VOLUMIO_VERSION="3.616"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="b343c71baf05cbc21bf1a530c8e51fc1"