-- Logs begin at Wed 2024-05-08 06:32:14 UTC, end at Wed 2024-05-08 06:50:47 UTC. -- May 08 06:49:03 volumio volumio[4301]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%98%A5%E9%9B%B7/e6ff70c0-01c5-4478-bce7-44c7ac257a1a.jpg' May 08 06:49:17 volumio volumio[4301]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%86%E8%8E%B2/95b4bc99-4e58-4269-b0bc-db939207cb49.jpg' May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 06:49:40 volumio volumio[4301]: info: Discovery: Getting this device information May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::volumioGetState May 08 06:49:40 volumio volumio[4301]: info: CorePlayQueue::getTrack 0 May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 06:49:40 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 08 06:49:45 volumio volumio[4301]: info: CoreCommandRouter::volumioGetState May 08 06:49:45 volumio volumio[4301]: info: CorePlayQueue::getTrack 0 May 08 06:49:45 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 08 06:49:45 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::volumioNext May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::next May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::stop May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 06:50:23 volumio volumio[4301]: UNSET VOLATILE May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::play index undefined May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::startPlaybackTimer May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/电影民歌/Track (3).wav May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand stop May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::updateTrackBlock May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrackBlock May 08 06:50:23 volumio volumio[4301]: info: May 08 06:50:23 volumio volumio[4301]: ---------------------------- MPD announces state update: player May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand stop took 10 milliseconds May 08 06:50:23 volumio volumio[4301]: info: ControllerMpd::getState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand status May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand clear May 08 06:50:23 volumio volumio[4301]: info: May 08 06:50:23 volumio volumio[4301]: ---------------------------- MPD announces system playlist update May 08 06:50:23 volumio volumio[4301]: info: Ignoring MPD Status Update May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand status took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand clear took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/电影民歌/Track (3).wav" May 08 06:50:23 volumio volumio[4301]: error: updateQueue error: null May 08 06:50:23 volumio volumio[4301]: info: May 08 06:50:23 volumio volumio[4301]: ---------------------------- MPD announces system playlist update May 08 06:50:23 volumio volumio[4301]: info: Ignoring MPD Status Update May 08 06:50:23 volumio volumio[4301]: info: ------------------------------ 3ms May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand playlistinfo took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand add "INTERNAL/电影民歌/Track (3).wav" took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseTrackInfo May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand play May 08 06:50:23 volumio volumio[4301]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 08 06:50:23 volumio volumio[4301]: info: ------------------------------ 6ms May 08 06:50:23 volumio volumio[4301]: info: ------------------------------ 2ms May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand play took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: info: May 08 06:50:23 volumio volumio[4301]: ---------------------------- MPD announces state update: player May 08 06:50:23 volumio volumio[4301]: info: ControllerMpd::getState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand status May 08 06:50:23 volumio volumio[4301]: info: May 08 06:50:23 volumio volumio[4301]: ---------------------------- MPD announces state update: player May 08 06:50:23 volumio volumio[4301]: info: ControllerMpd::getState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand status May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand status took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand status took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseState May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand playlistinfo took 1 milliseconds May 08 06:50:23 volumio volumio[4301]: info: sendMpdCommand playlistinfo took 0 milliseconds May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseTrackInfo May 08 06:50:23 volumio volumio[4301]: verbose: ControllerMpd::parseTrackInfo May 08 06:50:23 volumio volumio[4301]: info: ControllerMpd::pushState May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::servicePushState May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":348,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track (3).wav","artist":null,"album":null,"uri":"INTERNAL/电影民歌/Track (3).wav","trackType":"wav"} May 08 06:50:23 volumio volumio[4301]: verbose: CURRENT POSITION 12 May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::syncState stateService play May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::syncState currentStatus stop May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::pushState May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::volumioPushState May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 06:50:23 volumio volumio[4301]: info: ControllerMpd::pushState May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::servicePushState May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: verbose: STATE SERVICE {"status":"play","position":0,"seek":348,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track (3).wav","artist":null,"album":null,"uri":"INTERNAL/电影民歌/Track (3).wav","trackType":"wav"} May 08 06:50:23 volumio volumio[4301]: verbose: CURRENT POSITION 12 May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::syncState stateService play May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::syncState currentStatus play May 08 06:50:23 volumio volumio[4301]: info: Received an update from plugin. extracting info from payload May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::pushState May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::volumioPushState May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 06:50:23 volumio volumio[4301]: info: CoreStateMachine::pushState May 08 06:50:23 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::volumioPushState May 08 06:50:23 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 06:50:23 volumio volumio[4301]: info: ------------------------------ 15ms May 08 06:50:23 volumio volumio[4301]: info: ------------------------------ 14ms May 08 06:50:33 volumio volumio[4301]: info: CoreCommandRouter::volumioPause May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::pause May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::stPlaybackTimer May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::servicePause May 08 06:50:33 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:33 volumio volumio[4301]: info: CoreCommandRouter::servicePause May 08 06:50:33 volumio volumio[4301]: info: ControllerMpd::pause May 08 06:50:33 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand pause May 08 06:50:33 volumio volumio[4301]: info: May 08 06:50:33 volumio volumio[4301]: ---------------------------- MPD announces state update: player May 08 06:50:33 volumio volumio[4301]: info: sendMpdCommand pause took 19 milliseconds May 08 06:50:33 volumio volumio[4301]: info: ControllerMpd::getState May 08 06:50:33 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand status May 08 06:50:33 volumio volumio[4301]: info: sendMpdCommand status took 0 milliseconds May 08 06:50:33 volumio volumio[4301]: verbose: ControllerMpd::parseState May 08 06:50:33 volumio volumio[4301]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 08 06:50:33 volumio volumio[4301]: info: sendMpdCommand playlistinfo took 0 milliseconds May 08 06:50:33 volumio volumio[4301]: verbose: ControllerMpd::parseTrackInfo May 08 06:50:33 volumio volumio[4301]: info: ControllerMpd::pushState May 08 06:50:33 volumio volumio[4301]: info: CoreCommandRouter::servicePushState May 08 06:50:33 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:33 volumio volumio[4301]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9822,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track (3).wav","artist":null,"album":null,"uri":"INTERNAL/电影民歌/Track (3).wav","trackType":"wav"} May 08 06:50:33 volumio volumio[4301]: verbose: CURRENT POSITION 12 May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::syncState stateService pause May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::syncState currentStatus pause May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::pushState May 08 06:50:33 volumio volumio[4301]: info: CorePlayQueue::getTrack 12 May 08 06:50:33 volumio volumio[4301]: info: CoreCommandRouter::volumioPushState May 08 06:50:33 volumio volumio[4301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 06:50:33 volumio volumio[4301]: info: CoreStateMachine::stPlaybackTimer May 08 06:50:33 volumio volumio[4301]: info: ------------------------------ 4ms May 08 06:50:46 volumio volumio[4301]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 06:50:46 volumio volumio[4301]: { Error: connect ETIMEDOUT 108.160.167.147:80 May 08 06:50:46 volumio volumio[4301]: at Object._errnoException (util.js:1022:11) May 08 06:50:46 volumio volumio[4301]: at _exceptionWithHostPort (util.js:1044:20) May 08 06:50:46 volumio volumio[4301]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 08 06:50:46 volumio volumio[4301]: code: 'ETIMEDOUT', May 08 06:50:46 volumio volumio[4301]: errno: 'ETIMEDOUT', May 08 06:50:46 volumio volumio[4301]: syscall: 'connect', May 08 06:50:46 volumio volumio[4301]: address: '108.160.167.147', May 08 06:50:46 volumio volumio[4301]: port: 80 } May 08 06:50:46 volumio volumio[4301]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 06:50:47 volumio sudo[4923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-08 06:49 May 08 06:50:47 volumio sudo[4923]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:33:16 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="6e5c976a6d85b8b7d7e4e3388d208cd8"