-- Logs begin at Sun 2025-05-18 23:03:44 UTC, end at Thu 2025-05-22 17:01:28 UTC. -- May 22 17:00:35 volumio volumio[4871]: info: Clearing queue after UPNP request May 22 17:00:35 volumio volumio[4871]: info: CoreStateMachine::ClearQueue May 22 17:00:35 volumio volumio[4871]: info: CoreStateMachine::stop May 22 17:00:35 volumio volumio[4871]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 17:00:35 volumio volumio[4871]: UNSET VOLATILE May 22 17:00:35 volumio volumio[4871]: info: CorePlayQueue::clearPlayQueue May 22 17:00:35 volumio volumio[4871]: info: CorePlayQueue::saveQueue May 22 17:00:35 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:35 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:35 volumio volumio[4871]: info: CoreCommandRouter::volumioPushQueue May 22 17:00:35 volumio volumio[4871]: info: May 22 17:00:35 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:35 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:35 volumio volumio[4871]: error: updateQueue error: null May 22 17:00:35 volumio volumio[4871]: info: ------------------------------ 4ms May 22 17:00:35 volumio volumio[4871]: info: Starting UPNP Playback May 22 17:00:35 volumio volumio[4871]: info: Preparing playback through UPNP May 22 17:00:35 volumio volumio[4871]: info: CoreCommandRouter::volumioGetState May 22 17:00:35 volumio volumio[4871]: info: CorePlayQueue::getTrack 0 May 22 17:00:35 volumio volumio[4871]: info: CoreStateMachine::setConsumeUpdateService mpd May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 6ms May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 6ms May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 6ms May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 4ms May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- MPD announces system playlist update May 22 17:00:36 volumio volumio[4871]: info: Ignoring MPD Status Update May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 5ms May 22 17:00:36 volumio volumio[4871]: info: ------------------------------ 4ms May 22 17:00:36 volumio volumio[5106]: 100 May 22 17:00:36 volumio volumio[5106]: % Total % Received % Xferd Average Speed Time Time Time Current May 22 17:00:36 volumio volumio[5106]: Dload Upload Total Spent Left Speed May 22 17:00:36 volumio volumio[4871]: info: May 22 17:00:36 volumio volumio[4871]: ---------------------------- Client requests Volume 100 May 22 17:00:36 volumio volumio[4871]: info: VolumeController::SetAlsaVolume100 May 22 17:00:36 volumio volumio[4871]: info: CoreStateMachine::pushState May 22 17:00:36 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:36 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:36 volumio volumio[5106]: [234B blob data] May 22 17:00:36 volumio volumio[5106]: {"time":1747933236525,"response":"volume Success"}100 May 22 17:00:44 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=96000, same source mode(0) May 22 17:00:44 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs May 22 17:00:44 volumio kernel: aml_spdif_dai: iec958 mode PCM16 May 22 17:00:44 volumio kernel: aml_spdif_dai: sample_rate==AUDIO_CLK_FREQ_96 May 22 17:00:44 volumio kernel: aml_audio_hw: IEC958 16bit May 22 17:00:44 volumio kernel: hdmitx: audio: aout notify rate 96000 May 22 17:00:44 volumio kernel: hdmitx: audio: aout notify size 16 May 22 17:00:44 volumio kernel: hdmitx: audio: no update May 22 17:00:44 volumio volumio[4871]: info: May 22 17:00:44 volumio volumio[4871]: ---------------------------- MPD announces state update: player May 22 17:00:44 volumio volumio[4871]: info: ControllerMpd::getState May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand status May 22 17:00:44 volumio volumio[4871]: info: May 22 17:00:44 volumio volumio[4871]: ---------------------------- MPD announces state update: player May 22 17:00:44 volumio volumio[4871]: info: ControllerMpd::getState May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand status May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::parseState May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::parseState May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::parseTrackInfo May 22 17:00:44 volumio volumio[4871]: info: ControllerMpd::pushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::servicePushState May 22 17:00:44 volumio volumio[4871]: In UPNP mode May 22 17:00:44 volumio volumio[4871]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"喔伊细","artist":"徐佳莹","album":"首张创作专辑","uri":"http://192.168.0.112:58811/bridge-3.flac","trackType":"flac"} May 22 17:00:44 volumio volumio[4871]: verbose: CURRENT POSITION 0 May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::syncState stateService play May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::syncState currentStatus stop May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::pushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:44 volumio volumio[4871]: info: ------------------------------ 69ms May 22 17:00:44 volumio volumio[4871]: verbose: ControllerMpd::parseTrackInfo May 22 17:00:44 volumio volumio[4871]: info: ControllerMpd::pushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::servicePushState May 22 17:00:44 volumio volumio[4871]: In UPNP mode May 22 17:00:44 volumio volumio[4871]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"465 Kbps","isStreaming":false,"title":"喔伊细","artist":"徐佳莹","album":"首张创作专辑","uri":"http://192.168.0.112:58811/bridge-3.flac","trackType":"flac"} May 22 17:00:44 volumio volumio[4871]: verbose: CURRENT POSITION 0 May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::syncState stateService play May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::syncState currentStatus play May 22 17:00:44 volumio volumio[4871]: info: Received an update from plugin. extracting info from payload May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::pushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::pushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:44 volumio volumio[4871]: info: ------------------------------ 54ms May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::volumioGetQueue May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::getQueue May 22 17:00:44 volumio volumio[4871]: info: CorePlayQueue::getQueue May 22 17:00:44 volumio volumio[4871]: info: CoreCommandRouter::volumioGetQueue May 22 17:00:44 volumio volumio[4871]: info: CoreStateMachine::getQueue May 22 17:00:44 volumio volumio[4871]: info: CorePlayQueue::getQueue May 22 17:00:44 volumio kernel: aml_spdif_dai: aiu 958 playback enable May 22 17:00:57 volumio kernel: aml_spdif_dai: aiu 958 playback disable May 22 17:00:57 volumio volumio[4871]: info: May 22 17:00:57 volumio volumio[4871]: ---------------------------- MPD announces state update: player May 22 17:00:57 volumio volumio[4871]: info: ControllerMpd::getState May 22 17:00:57 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand status May 22 17:00:57 volumio volumio[4871]: verbose: ControllerMpd::parseState May 22 17:00:57 volumio volumio[4871]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 17:00:57 volumio volumio[4871]: verbose: ControllerMpd::parseTrackInfo May 22 17:00:57 volumio volumio[4871]: info: ControllerMpd::pushState May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::servicePushState May 22 17:00:57 volumio volumio[4871]: info: CoreStateMachine::pushState May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:57 volumio volumio[4871]: info: CorePlayQueue::getTrack 0 May 22 17:00:57 volumio volumio[4871]: 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":"喔伊细","artist":"徐佳莹","album":"首张创作专辑","uri":"http://192.168.0.112:58811/bridge-3.flac","trackType":"flac"} May 22 17:00:57 volumio volumio[4871]: verbose: CURRENT POSITION 0 May 22 17:00:57 volumio volumio[4871]: info: CoreStateMachine::syncState stateService stop May 22 17:00:57 volumio volumio[4871]: info: CoreStateMachine::syncState currentStatus play May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::volumioPushState May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:00:57 volumio volumio[4871]: info: CoreStateMachine::stPlaybackTimer May 22 17:00:57 volumio volumio[4871]: info: ------------------------------ 41ms May 22 17:00:57 volumio volumio[4871]: info: CoreCommandRouter::volumioGetQueue May 22 17:00:57 volumio volumio[4871]: info: CoreStateMachine::getQueue May 22 17:00:57 volumio volumio[4871]: info: CorePlayQueue::getQueue May 22 17:01:27 volumio volumio[4871]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 17:01:27 volumio volumio[4871]: { Error: connect ETIMEDOUT 108.160.169.179:443 May 22 17:01:27 volumio volumio[4871]: at Object._errnoException (util.js:1022:11) May 22 17:01:27 volumio volumio[4871]: at _exceptionWithHostPort (util.js:1044:20) May 22 17:01:27 volumio volumio[4871]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 22 17:01:27 volumio volumio[4871]: code: 'ETIMEDOUT', May 22 17:01:27 volumio volumio[4871]: errno: 'ETIMEDOUT', May 22 17:01:27 volumio volumio[4871]: syscall: 'connect', May 22 17:01:27 volumio volumio[4871]: address: '108.160.169.179', May 22 17:01:27 volumio volumio[4871]: port: 443 } May 22 17:01:27 volumio volumio[4871]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 17:01:28 volumio sudo[7098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 17:00 May 22 17:01:28 volumio sudo[7098]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"