-- Logs begin at Thu 2024-11-21 14:59:56 UTC, end at Thu 2024-11-21 16:05:10 UTC. -- Nov 21 16:04:33 volumio volumio[16690]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%A6%8F%E5%B1%B1%E9%9B%85%E6%B2%BB/%E7%A6%8F%E3%81%AE%E9%9F%B3/015aecb1-c593-4736-8696-e9f73b48cc1b.jpg' Nov 21 16:04:33 volumio volumio[16690]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/CHIHIRO/C%20is/d7598176-09ae-4b2b-b9aa-505ababf4830.jpg' Nov 21 16:04:37 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 16:04:37 volumio volumio[16690]: info: CURURI: albums:// Nov 21 16:04:37 volumio volumio[16690]: listAlbums - loading Albums from cache Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioAddQueueItems Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::addQueueItems Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::addQueueItems Nov 21 16:05:07 volumio volumio[16690]: info: Adding Item to queue: albums://%E5%AE%89%E5%85%A8%E5%9C%B0%E5%B8%AF/I%20LOVE%20YOU%E3%81%8B%E3%82%89%E3%81%AF%E3%81%98%E3%82%81%E3%82%88%E3%81%86%20-%20%E5%AE%89%E5%85%A8%E5%9C%B0%E5%B8%AFBEST%20- Nov 21 16:05:07 volumio volumio[16690]: info: Exploding uri albums://%E5%AE%89%E5%85%A8%E5%9C%B0%E5%B8%AF/I%20LOVE%20YOU%E3%81%8B%E3%82%89%E3%81%AF%E3%81%98%E3%82%81%E3%82%88%E3%81%86%20-%20%E5%AE%89%E5%85%A8%E5%9C%B0%E5%B8%AFBEST%20- in service mpd Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::saveQueue Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPushQueue Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::updateTrackBlock Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrackBlock Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPlay Nov 21 16:05:07 volumio volumio[16690]: verbose: UNSET VOLATILE Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::play index 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::stop Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:05:07 volumio volumio[16690]: verbose: UNSET VOLATILE Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::stPlaybackTimer Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::updateTrackBlock Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrackBlock Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 13 Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::serviceStop Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 13 Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::serviceStop Nov 21 16:05:07 volumio volumio[16690]: info: ControllerMpd::stop Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 16:05:07 volumio volumio[16690]: info: Nov 21 16:05:07 volumio volumio[16690]: ---------------------------- MPD announces state update: player Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand stop took 178 milliseconds Nov 21 16:05:07 volumio volumio[16690]: info: ControllerMpd::getState Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::play index undefined Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/缓存/02.mp3/安全地帯 - 好きさ.mp3 Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand status took 7 milliseconds Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand stop took 5 milliseconds Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::parseState Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 16:05:07 volumio volumio[16690]: info: Nov 21 16:05:07 volumio volumio[16690]: ---------------------------- MPD announces system playlist update Nov 21 16:05:07 volumio volumio[16690]: info: Ignoring MPD Status Update Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand clear took 2 milliseconds Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/缓存/02.mp3/安全地帯 - 好きさ.mp3" Nov 21 16:05:07 volumio volumio[16690]: info: ControllerMpd::pushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::servicePushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: 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":"This Is No Ordinary Love","artist":"Carol Duboc","album":"鉴听女声天碟CD1","uri":"NAS/鉴听女声天碟CD1/13 This Is No Ordinary Love.m4a","trackType":"m4a"} Nov 21 16:05:07 volumio volumio[16690]: verbose: CURRENT POSITION 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::syncState stateService stop Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::syncState currentStatus stop Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:07 volumio volumio[16690]: info: No code Nov 21 16:05:07 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:07 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:07 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:07 volumio volumio[16690]: info: ------------------------------ 34ms Nov 21 16:05:07 volumio volumio[16690]: error: updateQueue error: null Nov 21 16:05:07 volumio volumio[16690]: info: Nov 21 16:05:07 volumio volumio[16690]: ---------------------------- MPD announces system playlist update Nov 21 16:05:07 volumio volumio[16690]: info: Ignoring MPD Status Update Nov 21 16:05:07 volumio volumio[16690]: info: ------------------------------ 27ms Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand add "NAS/NAS/缓存/02.mp3/安全地帯 - 好きさ.mp3" took 25 milliseconds Nov 21 16:05:07 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand play Nov 21 16:05:07 volumio volumio[16690]: info: ------------------------------ 7ms Nov 21 16:05:07 volumio volumio[16690]: info: sendMpdCommand play took 4 milliseconds Nov 21 16:05:08 volumio volumio[16690]: info: Nov 21 16:05:08 volumio volumio[16690]: ---------------------------- MPD announces state update: player Nov 21 16:05:08 volumio volumio[16690]: info: ControllerMpd::getState Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:05:08 volumio volumio[16690]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 21 16:05:08 volumio volumio[16690]: info: Nov 21 16:05:08 volumio volumio[16690]: ---------------------------- MPD announces state update: player Nov 21 16:05:08 volumio volumio[16690]: info: ControllerMpd::getState Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:05:08 volumio volumio[16690]: info: sendMpdCommand status took 3 milliseconds Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::parseState Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:05:08 volumio volumio[16690]: info: sendMpdCommand status took 2 milliseconds Nov 21 16:05:08 volumio volumio[16690]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::parseState Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:05:08 volumio volumio[16690]: info: ControllerMpd::pushState Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::servicePushState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"好きさ","artist":"安全地帯","album":"I LOVE YOUからはじめよう - 安全地帯BEST -","uri":"NAS/NAS/缓存/02.mp3/安全地帯 - 好きさ.mp3","trackType":"mp3"} Nov 21 16:05:08 volumio volumio[16690]: verbose: CURRENT POSITION 961 Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::syncState stateService play Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::syncState currentStatus stop Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:08 volumio volumio[16690]: info: ------------------------------ 15ms Nov 21 16:05:08 volumio volumio[16690]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 21 16:05:08 volumio volumio[16690]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:05:08 volumio volumio[16690]: info: ControllerMpd::pushState Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::servicePushState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"好きさ","artist":"安全地帯","album":"I LOVE YOUからはじめよう - 安全地帯BEST -","uri":"NAS/NAS/缓存/02.mp3/安全地帯 - 好きさ.mp3","trackType":"mp3"} Nov 21 16:05:08 volumio volumio[16690]: verbose: CURRENT POSITION 961 Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::syncState stateService play Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::syncState currentStatus play Nov 21 16:05:08 volumio volumio[16690]: info: Received an update from plugin. extracting info from payload Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:08 volumio volumio[16690]: info: CoreStateMachine::pushState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::volumioPushState Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:05:08 volumio volumio[16690]: info: ------------------------------ 32ms Nov 21 16:05:08 volumio volumio[16690]: info: CoreCommandRouter::volumioGetState Nov 21 16:05:08 volumio volumio[16690]: info: CorePlayQueue::getTrack 961 Nov 21 16:05:08 volumio volumio[16690]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 21 16:05:08 volumio volumio[16690]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 21 16:05:08 volumio volumio[16690]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 21 16:05:10 volumio volumio[16690]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 16:05:10 volumio volumio[16690]: { Error: connect ETIMEDOUT 128.242.240.253:443 Nov 21 16:05:10 volumio volumio[16690]: at Object._errnoException (util.js:1022:11) Nov 21 16:05:10 volumio volumio[16690]: at _exceptionWithHostPort (util.js:1044:20) Nov 21 16:05:10 volumio volumio[16690]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 21 16:05:10 volumio volumio[16690]: code: 'ETIMEDOUT', Nov 21 16:05:10 volumio volumio[16690]: errno: 'ETIMEDOUT', Nov 21 16:05:10 volumio volumio[16690]: syscall: 'connect', Nov 21 16:05:10 volumio volumio[16690]: address: '128.242.240.253', Nov 21 16:05:10 volumio volumio[16690]: port: 443 } Nov 21 16:05:10 volumio volumio[16690]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 16:05:10 volumio sudo[18079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 16:04 Nov 21 16:05:10 volumio sudo[18079]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"