-- Logs begin at Wed 2025-06-25 11:23:39 UTC, end at Mon 2025-06-30 09:29:52 UTC. -- Jun 30 09:28:20 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jun 30 09:28:20 volumio volumio[4861]: info: Jun 30 09:28:20 volumio volumio[4861]: ---------------------------- MPD announces state update: player Jun 30 09:28:20 volumio volumio[4861]: info: ControllerMpd::getState Jun 30 09:28:20 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand status Jun 30 09:28:20 volumio volumio[4861]: verbose: ControllerMpd::parseState Jun 30 09:28:20 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 09:28:20 volumio volumio[4861]: verbose: ControllerMpd::parseTrackInfo Jun 30 09:28:20 volumio volumio[4861]: info: ControllerMpd::pushState Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::servicePushState Jun 30 09:28:20 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:20 volumio volumio[4861]: info: CorePlayQueue::getTrack 0 Jun 30 09:28:20 volumio volumio[4861]: 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":"Crazy in Love (feat. Jay-Z)","artist":"Beyonce","album":"Dangerously in Love","uri":"http://192.168.0.164:58541/bridge-1.flac","trackType":"flac"} Jun 30 09:28:20 volumio volumio[4861]: verbose: CURRENT POSITION 0 Jun 30 09:28:20 volumio volumio[4861]: info: CoreStateMachine::syncState stateService stop Jun 30 09:28:20 volumio volumio[4861]: info: CoreStateMachine::syncState currentStatus play Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:20 volumio volumio[4861]: info: CoreStateMachine::stPlaybackTimer Jun 30 09:28:20 volumio volumio[4861]: info: ------------------------------ 47ms Jun 30 09:28:20 volumio volumio[4861]: info: CoreCommandRouter::volumioGetQueue Jun 30 09:28:20 volumio volumio[4861]: info: CoreStateMachine::getQueue Jun 30 09:28:20 volumio volumio[4861]: info: CorePlayQueue::getQueue Jun 30 09:28:21 volumio volumio[4861]: info: Clearing queue after UPNP request Jun 30 09:28:21 volumio volumio[4861]: info: CoreStateMachine::ClearQueue Jun 30 09:28:21 volumio volumio[4861]: info: CoreStateMachine::stop Jun 30 09:28:21 volumio volumio[4861]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 09:28:21 volumio volumio[4861]: UNSET VOLATILE Jun 30 09:28:21 volumio volumio[4861]: info: CorePlayQueue::clearPlayQueue Jun 30 09:28:21 volumio volumio[4861]: info: CorePlayQueue::saveQueue Jun 30 09:28:21 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:21 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:21 volumio volumio[4861]: info: CoreCommandRouter::volumioPushQueue Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: error: updateQueue error: null Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 5ms Jun 30 09:28:21 volumio volumio[4861]: info: Starting UPNP Playback Jun 30 09:28:21 volumio volumio[4861]: info: Preparing playback through UPNP Jun 30 09:28:21 volumio volumio[4861]: info: CoreCommandRouter::volumioGetState Jun 30 09:28:21 volumio volumio[4861]: info: CorePlayQueue::getTrack 0 Jun 30 09:28:21 volumio volumio[4861]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 3ms Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 4ms Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 4ms Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 4ms Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 4ms Jun 30 09:28:21 volumio volumio[4861]: info: Jun 30 09:28:21 volumio volumio[4861]: ---------------------------- MPD announces system playlist update Jun 30 09:28:21 volumio volumio[4861]: info: Ignoring MPD Status Update Jun 30 09:28:21 volumio volumio[4861]: info: ------------------------------ 4ms Jun 30 09:28:22 volumio volumio[5023]: 49 Jun 30 09:28:22 volumio volumio[5023]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 30 09:28:22 volumio volumio[5023]: Dload Upload Total Spent Left Speed Jun 30 09:28:22 volumio volumio[4861]: info: Jun 30 09:28:22 volumio volumio[4861]: ---------------------------- Client requests Volume 49 Jun 30 09:28:22 volumio volumio[4861]: info: VolumeController::SetAlsaVolume49 Jun 30 09:28:22 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:28:22 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:22 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:22 volumio volumio[5023]: [155B blob data] Jun 30 09:28:22 volumio volumio[5023]: {"time":1751275702057,"response":"volume Success"}49 Jun 30 09:28:22 volumio volumio[4861]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyonce/Dangerously%20in%20Love/49e2e47c-7748-4409-b208-43cf08254572.png' Jun 30 09:28:23 volumio volumio[4861]: info: Jun 30 09:28:23 volumio volumio[4861]: ---------------------------- MPD announces state update: player Jun 30 09:28:23 volumio volumio[4861]: info: ControllerMpd::getState Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand status Jun 30 09:28:24 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=96000, same source mode(0) Jun 30 09:28:24 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Jun 30 09:28:24 volumio kernel: aml_spdif_dai: iec958 mode PCM16 Jun 30 09:28:24 volumio kernel: aml_spdif_dai: sample_rate==AUDIO_CLK_FREQ_96 Jun 30 09:28:24 volumio kernel: aml_audio_hw: IEC958 16bit Jun 30 09:28:24 volumio kernel: hdmitx: audio: aout notify rate 96000 Jun 30 09:28:24 volumio kernel: hdmitx: audio: aout notify size 16 Jun 30 09:28:24 volumio kernel: hdmitx: audio: no update Jun 30 09:28:24 volumio volumio[4861]: info: Jun 30 09:28:24 volumio volumio[4861]: ---------------------------- MPD announces state update: player Jun 30 09:28:24 volumio volumio[4861]: info: ControllerMpd::getState Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand status Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::parseState Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::parseState Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::parseTrackInfo Jun 30 09:28:24 volumio volumio[4861]: info: ControllerMpd::pushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::servicePushState Jun 30 09:28:24 volumio volumio[4861]: In UPNP mode Jun 30 09:28:24 volumio volumio[4861]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"感应","artist":"纵贯线","album":"纵贯天下 CD1","uri":"http://192.168.0.164:35307/bridge-2.flac","trackType":"flac"} Jun 30 09:28:24 volumio volumio[4861]: verbose: CURRENT POSITION 0 Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::syncState stateService play Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::syncState currentStatus stop Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:24 volumio volumio[4861]: info: ------------------------------ 84ms Jun 30 09:28:24 volumio volumio[4861]: verbose: ControllerMpd::parseTrackInfo Jun 30 09:28:24 volumio volumio[4861]: info: ControllerMpd::pushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::servicePushState Jun 30 09:28:24 volumio volumio[4861]: In UPNP mode Jun 30 09:28:24 volumio volumio[4861]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"感应","artist":"纵贯线","album":"纵贯天下 CD1","uri":"http://192.168.0.164:35307/bridge-2.flac","trackType":"flac"} Jun 30 09:28:24 volumio volumio[4861]: verbose: CURRENT POSITION 0 Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::syncState stateService play Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::syncState currentStatus play Jun 30 09:28:24 volumio volumio[4861]: info: Received an update from plugin. extracting info from payload Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:28:24 volumio kernel: aml_spdif_dai: aiu 958 playback enable Jun 30 09:28:24 volumio volumio[4861]: info: ------------------------------ 68ms Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::volumioGetQueue Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::getQueue Jun 30 09:28:24 volumio volumio[4861]: info: CorePlayQueue::getQueue Jun 30 09:28:24 volumio volumio[4861]: info: CoreCommandRouter::volumioGetQueue Jun 30 09:28:24 volumio volumio[4861]: info: CoreStateMachine::getQueue Jun 30 09:28:24 volumio volumio[4861]: info: CorePlayQueue::getQueue Jun 30 09:29:21 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jun 30 09:29:21 volumio volumio[4861]: info: Jun 30 09:29:21 volumio volumio[4861]: ---------------------------- MPD announces state update: player Jun 30 09:29:21 volumio volumio[4861]: info: ControllerMpd::getState Jun 30 09:29:21 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand status Jun 30 09:29:21 volumio volumio[4861]: verbose: ControllerMpd::parseState Jun 30 09:29:21 volumio volumio[4861]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 09:29:21 volumio volumio[4861]: verbose: ControllerMpd::parseTrackInfo Jun 30 09:29:21 volumio volumio[4861]: info: ControllerMpd::pushState Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::servicePushState Jun 30 09:29:21 volumio volumio[4861]: info: CoreStateMachine::pushState Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:29:21 volumio volumio[4861]: info: CorePlayQueue::getTrack 0 Jun 30 09:29:21 volumio volumio[4861]: 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":"纵贯天下 CD1","uri":"http://192.168.0.164:35307/bridge-2.flac","trackType":"flac"} Jun 30 09:29:21 volumio volumio[4861]: verbose: CURRENT POSITION 0 Jun 30 09:29:21 volumio volumio[4861]: info: CoreStateMachine::syncState stateService stop Jun 30 09:29:21 volumio volumio[4861]: info: CoreStateMachine::syncState currentStatus play Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::volumioPushState Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 09:29:21 volumio volumio[4861]: info: CoreStateMachine::stPlaybackTimer Jun 30 09:29:21 volumio volumio[4861]: info: ------------------------------ 40ms Jun 30 09:29:21 volumio volumio[4861]: info: CoreCommandRouter::volumioGetQueue Jun 30 09:29:21 volumio volumio[4861]: info: CoreStateMachine::getQueue Jun 30 09:29:21 volumio volumio[4861]: info: CorePlayQueue::getQueue Jun 30 09:29:28 volumio volumio[4861]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 09:29:28 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 09:29:28 volumio volumio[4861]: info: CoreCommandRouter::volumioGetState Jun 30 09:29:28 volumio volumio[4861]: info: CoreCommandRouter::volumioGetQueue Jun 30 09:29:28 volumio volumio[4861]: info: CoreStateMachine::getQueue Jun 30 09:29:28 volumio volumio[4861]: info: CorePlayQueue::getQueue Jun 30 09:29:28 volumio volumio[4861]: info: Listing playlists Jun 30 09:29:28 volumio volumio[4861]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 09:29:51 volumio volumio[4861]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 09:29:51 volumio volumio[4861]: { Error: connect ETIMEDOUT 199.59.148.8:443 Jun 30 09:29:51 volumio volumio[4861]: at Object._errnoException (util.js:1022:11) Jun 30 09:29:51 volumio volumio[4861]: at _exceptionWithHostPort (util.js:1044:20) Jun 30 09:29:51 volumio volumio[4861]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 30 09:29:51 volumio volumio[4861]: code: 'ETIMEDOUT', Jun 30 09:29:51 volumio volumio[4861]: errno: 'ETIMEDOUT', Jun 30 09:29:51 volumio volumio[4861]: syscall: 'connect', Jun 30 09:29:51 volumio volumio[4861]: address: '199.59.148.8', Jun 30 09:29:51 volumio volumio[4861]: port: 443 } Jun 30 09:29:51 volumio volumio[4861]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 09:29:52 volumio sudo[7658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 09:28 Jun 30 09:29:52 volumio sudo[7658]: 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"