-- Logs begin at Thu 2024-04-18 04:04:15 UTC, end at Thu 2024-04-18 04:12:10 UTC. -- Apr 18 04:11:22 lgzhifi systemd-journal[227]: Suppressed 7401 messages from /system.slice/volumio.service Apr 18 04:11:22 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 18 04:11:34 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::ClearQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::stop Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 04:11:37 lgzhifi volumio[947]: UNSET VOLATILE Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::clearPlayQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::saveQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushState Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::addQueueItems Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::addQueueItems Apr 18 04:11:37 lgzhifi volumio[947]: info: Adding Item to queue: upnp/folder/http://192.168.0.101:50001/ContentDirectory/control@22$1180 Apr 18 04:11:37 lgzhifi volumio[947]: info: Exploding uri upnp/folder/http://192.168.0.101:50001/ContentDirectory/control@22$1180 in service upnp_browser Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::saveQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushQueue Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::updateTrackBlock Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::getTrackBlock Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPlay Apr 18 04:11:37 lgzhifi volumio[947]: UNSET VOLATILE Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::play index 0 Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::stop Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 04:11:37 lgzhifi volumio[947]: UNSET VOLATILE Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::play index undefined Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::getTrack 0 Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::startPlaybackTimer Apr 18 04:11:37 lgzhifi volumio[947]: info: CorePlayQueue::getTrack 0 Apr 18 04:11:37 lgzhifi volumio[947]: info: [1713413497912] ControllerUPNPBrowser::clearAddPlayTrack Apr 18 04:11:37 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 04:11:37 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 04:11:37 lgzhifi volumio[947]: info: Apr 18 04:11:37 lgzhifi volumio[947]: ---------------------------- MPD announces system playlist update Apr 18 04:11:37 lgzhifi volumio[947]: info: Ignoring MPD Status Update Apr 18 04:11:37 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.101:50002/m/NDLNA/8915.FLAC" Apr 18 04:11:37 lgzhifi volumio[947]: error: updateQueue error: null Apr 18 04:11:37 lgzhifi volumio[947]: info: ------------------------------ 3ms Apr 18 04:11:37 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.101:50002/m/NDLNA/8915.FLAC" Apr 18 04:11:37 lgzhifi volumio[947]: info: Apr 18 04:11:37 lgzhifi volumio[947]: ---------------------------- MPD announces system playlist update Apr 18 04:11:37 lgzhifi volumio[947]: info: Ignoring MPD Status Update Apr 18 04:11:37 lgzhifi volumio[947]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 18 04:11:37 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand play Apr 18 04:11:37 lgzhifi volumio[947]: info: ------------------------------ 5ms Apr 18 04:11:38 lgzhifi volumio[947]: info: Apr 18 04:11:38 lgzhifi volumio[947]: ---------------------------- MPD announces state update: player Apr 18 04:11:38 lgzhifi volumio[947]: info: ControllerMpd::getState Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand status Apr 18 04:11:38 lgzhifi volumio[947]: info: Apr 18 04:11:38 lgzhifi volumio[947]: ---------------------------- MPD announces system playlist update Apr 18 04:11:38 lgzhifi volumio[947]: info: Ignoring MPD Status Update Apr 18 04:11:38 lgzhifi volumio[947]: info: Apr 18 04:11:38 lgzhifi volumio[947]: ---------------------------- MPD announces state update: player Apr 18 04:11:38 lgzhifi volumio[947]: info: ControllerMpd::getState Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand status Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::parseState Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 04:11:38 lgzhifi volumio[947]: info: ------------------------------ 15ms Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::parseState Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::parseTrackInfo Apr 18 04:11:38 lgzhifi volumio[947]: info: ControllerMpd::pushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::servicePushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CorePlayQueue::getTrack 0 Apr 18 04:11:38 lgzhifi volumio[947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":287,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"10 Kbps","isStreaming":false,"title":"女人花","artist":"梅艳芳","album":"女人花","uri":"http://192.168.0.101:50002/m/NDLNA/8915.FLAC","trackType":"FLAC"} Apr 18 04:11:38 lgzhifi volumio[947]: verbose: CURRENT POSITION 0 Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::syncState stateService play Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::syncState currentStatus stop Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::pushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 04:11:38 lgzhifi volumio[947]: info: ------------------------------ 62ms Apr 18 04:11:38 lgzhifi volumio[947]: verbose: ControllerMpd::parseTrackInfo Apr 18 04:11:38 lgzhifi volumio[947]: info: ControllerMpd::pushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::servicePushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CorePlayQueue::getTrack 0 Apr 18 04:11:38 lgzhifi volumio[947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":389,"duration":287,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"10 Kbps","isStreaming":false,"title":"女人花","artist":"梅艳芳","album":"女人花","uri":"http://192.168.0.101:50002/m/NDLNA/8915.FLAC","trackType":"FLAC"} Apr 18 04:11:38 lgzhifi volumio[947]: verbose: CURRENT POSITION 0 Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::syncState stateService play Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::syncState currentStatus play Apr 18 04:11:38 lgzhifi volumio[947]: info: Received an update from plugin. extracting info from payload Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::pushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::pushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::volumioPushState Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 04:11:38 lgzhifi volumio[947]: info: ------------------------------ 66ms Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::volumioGetQueue Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::getQueue Apr 18 04:11:38 lgzhifi volumio[947]: info: CorePlayQueue::getQueue Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreCommandRouter::volumioGetQueue Apr 18 04:11:38 lgzhifi volumio[947]: info: CoreStateMachine::getQueue Apr 18 04:11:38 lgzhifi volumio[947]: info: CorePlayQueue::getQueue Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:02 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:03 lgzhifi volumio[947]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/21/1173bd52-4499-4637-96e4-78b7e40465cd.jpg' Apr 18 04:12:10 lgzhifi volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 04:12:10 lgzhifi volumio[947]: { Error: connect ETIMEDOUT 64.13.192.74:443 Apr 18 04:12:10 lgzhifi volumio[947]: at Object._errnoException (util.js:1022:11) Apr 18 04:12:10 lgzhifi volumio[947]: at _exceptionWithHostPort (util.js:1044:20) Apr 18 04:12:10 lgzhifi volumio[947]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 18 04:12:10 lgzhifi volumio[947]: code: 'ETIMEDOUT', Apr 18 04:12:10 lgzhifi volumio[947]: errno: 'ETIMEDOUT', Apr 18 04:12:10 lgzhifi volumio[947]: syscall: 'connect', Apr 18 04:12:10 lgzhifi volumio[947]: address: '64.13.192.74', Apr 18 04:12:10 lgzhifi volumio[947]: port: 443 } Apr 18 04:12:10 lgzhifi volumio[947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 04:12:10 lgzhifi sudo[2300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-18 04:11 Apr 18 04:12:10 lgzhifi sudo[2300]: 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 23:01:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="f178c93fd665ce3cc494e7df97d93b1b"