-- Logs begin at Sat 2024-08-31 05:05:25 UTC, end at Sun 2024-09-01 07:13:47 UTC. -- Sep 01 07:12:25 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 01 07:12:25 volumio volumio[4680]: info: CURURI: artists://%E6%9C%AC%E5%85%AE Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::ClearQueue Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::stop Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 07:12:37 volumio volumio[4680]: UNSET VOLATILE Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::stPlaybackTimer Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::updateTrackBlock Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrackBlock Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 128 Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::serviceStop Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 128 Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::serviceStop Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::stop Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::clearPlayQueue Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::saveQueue Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushQueue Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::addQueueItems Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::addQueueItems Sep 01 07:12:37 volumio volumio[4680]: info: Adding Item to queue: artists://%E6%9C%AC%E5%85%AE Sep 01 07:12:37 volumio volumio[4680]: info: Exploding uri artists://%E6%9C%AC%E5%85%AE in service mpd Sep 01 07:12:37 volumio kernel: aml_spdif_dai: aiu 958 playback disable Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::saveQueue Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushQueue Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::updateTrackBlock Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrackBlock Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPlay Sep 01 07:12:37 volumio volumio[4680]: UNSET VOLATILE Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::play index 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::stop Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 07:12:37 volumio volumio[4680]: UNSET VOLATILE Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::play index undefined Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::startPlaybackTimer Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::clearAddPlayTracks NAS/mmcblk0p27/本兮-未成年.ape Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand stop Sep 01 07:12:37 volumio volumio[4680]: info: Sep 01 07:12:37 volumio volumio[4680]: ---------------------------- MPD announces state update: player Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::getState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand clear Sep 01 07:12:37 volumio volumio[4680]: info: Sep 01 07:12:37 volumio volumio[4680]: ---------------------------- MPD announces system playlist update Sep 01 07:12:37 volumio volumio[4680]: info: Ignoring MPD Status Update Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand add "NAS/mmcblk0p27/本兮-未成年.ape" Sep 01 07:12:37 volumio volumio[4680]: error: updateQueue error: null Sep 01 07:12:37 volumio volumio[4680]: info: Sep 01 07:12:37 volumio volumio[4680]: ---------------------------- MPD announces system playlist update Sep 01 07:12:37 volumio volumio[4680]: info: Ignoring MPD Status Update Sep 01 07:12:37 volumio volumio[4680]: info: ------------------------------ 7ms Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand play Sep 01 07:12:37 volumio volumio[4680]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 01 07:12:37 volumio volumio[4680]: info: ------------------------------ 16ms Sep 01 07:12:37 volumio volumio[4680]: info: ------------------------------ 11ms Sep 01 07:12:37 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, same source mode(0) Sep 01 07:12:37 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Sep 01 07:12:37 volumio kernel: aml_spdif_dai: iec958 mode PCM16 Sep 01 07:12:37 volumio kernel: aml_audio_hw: IEC958 16bit Sep 01 07:12:37 volumio volumio[4680]: info: Sep 01 07:12:37 volumio volumio[4680]: ---------------------------- MPD announces state update: player Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::getState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:12:37 volumio kernel: hdmitx: audio: aout notify rate 48000 Sep 01 07:12:37 volumio kernel: hdmitx: audio: aout notify size 16 Sep 01 07:12:37 volumio kernel: hdmitx: audio: no update Sep 01 07:12:37 volumio volumio[4680]: info: Sep 01 07:12:37 volumio volumio[4680]: ---------------------------- MPD announces state update: player Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::getState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseState Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::servicePushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未成年","artist":"本兮","album":"GO!GO!未成年","uri":"NAS/mmcblk0p27/本兮-未成年.ape","trackType":"ape"} Sep 01 07:12:37 volumio volumio[4680]: verbose: CURRENT POSITION 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::syncState stateService play Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::syncState currentStatus stop Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:12:37 volumio volumio[4680]: info: ------------------------------ 54ms Sep 01 07:12:37 volumio volumio[4680]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:12:37 volumio volumio[4680]: info: ControllerMpd::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::servicePushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":274,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未成年","artist":"本兮","album":"GO!GO!未成年","uri":"NAS/mmcblk0p27/本兮-未成年.ape","trackType":"ape"} Sep 01 07:12:37 volumio volumio[4680]: verbose: CURRENT POSITION 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::syncState stateService play Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::syncState currentStatus play Sep 01 07:12:37 volumio volumio[4680]: info: Received an update from plugin. extracting info from payload Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:12:37 volumio volumio[4680]: info: CoreStateMachine::pushState Sep 01 07:12:37 volumio volumio[4680]: info: CorePlayQueue::getTrack 0 Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::volumioPushState Sep 01 07:12:37 volumio volumio[4680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:12:37 volumio volumio[4680]: info: ------------------------------ 70ms Sep 01 07:12:37 volumio kernel: aml_spdif_dai: aiu 958 playback enable Sep 01 07:13:46 volumio volumio[4680]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 07:13:46 volumio volumio[4680]: { Error: connect ETIMEDOUT 69.63.184.142:80 Sep 01 07:13:46 volumio volumio[4680]: at Object._errnoException (util.js:1022:11) Sep 01 07:13:46 volumio volumio[4680]: at _exceptionWithHostPort (util.js:1044:20) Sep 01 07:13:46 volumio volumio[4680]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 01 07:13:46 volumio volumio[4680]: code: 'ETIMEDOUT', Sep 01 07:13:46 volumio volumio[4680]: errno: 'ETIMEDOUT', Sep 01 07:13:46 volumio volumio[4680]: syscall: 'connect', Sep 01 07:13:46 volumio volumio[4680]: address: '69.63.184.142', Sep 01 07:13:46 volumio volumio[4680]: port: 80 } Sep 01 07:13:46 volumio volumio[4680]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 07:13:47 volumio sudo[13114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 07:12 Sep 01 07:13:47 volumio sudo[13114]: 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"