-- Logs begin at Sat 2024-10-05 13:12:37 UTC, end at Sat 2024-10-05 14:01:43 UTC. -- Oct 05 14:00:09 volumio volumio[10224]: info: Oct 05 14:00:09 volumio volumio[10224]: ---------------------------- MPD announces state update: player Oct 05 14:00:09 volumio volumio[10224]: info: ControllerMpd::getState Oct 05 14:00:09 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand status Oct 05 14:00:09 volumio volumio[10224]: verbose: ControllerMpd::parseState Oct 05 14:00:09 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 14:00:09 volumio volumio[10224]: verbose: ControllerMpd::parseTrackInfo Oct 05 14:00:09 volumio volumio[10224]: info: ControllerMpd::pushState Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::servicePushState Oct 05 14:00:09 volumio volumio[10224]: info: CoreStateMachine::pushState Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:09 volumio volumio[10224]: info: CorePlayQueue::getTrack 0 Oct 05 14:00:09 volumio volumio[10224]: 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":"you'd never know","artist":"Blü Eyes","album":"you'd never know","uri":"http://aqqmusic.tc.qq.com/F000002M0ZM81bjQMm.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=48D0B4F380086FE312EDC1DFFFB834936C868A0E3C572E0331DCAC6E3F4BEB07B47CABF75DAB5665559BD8CB3FB6E81AFE585B940135E772&uin=1259438298&src=F000002UTd3815bBlY.flac&redirect=1&fromtag=111114","trackType":""} Oct 05 14:00:09 volumio volumio[10224]: verbose: CURRENT POSITION 0 Oct 05 14:00:09 volumio volumio[10224]: info: CoreStateMachine::syncState stateService stop Oct 05 14:00:09 volumio volumio[10224]: info: CoreStateMachine::syncState currentStatus play Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:09 volumio volumio[10224]: info: CoreStateMachine::stPlaybackTimer Oct 05 14:00:09 volumio volumio[10224]: info: ------------------------------ 22ms Oct 05 14:00:09 volumio volumio[10224]: info: CoreCommandRouter::volumioGetQueue Oct 05 14:00:09 volumio volumio[10224]: info: CoreStateMachine::getQueue Oct 05 14:00:09 volumio volumio[10224]: info: CorePlayQueue::getQueue Oct 05 14:00:09 volumio volumio[10224]: info: Clearing queue after UPNP request Oct 05 14:00:10 volumio volumio[10224]: info: CoreStateMachine::ClearQueue Oct 05 14:00:10 volumio volumio[10224]: info: CoreStateMachine::stop Oct 05 14:00:10 volumio volumio[10224]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 05 14:00:10 volumio volumio[10224]: UNSET VOLATILE Oct 05 14:00:10 volumio volumio[10224]: info: CorePlayQueue::clearPlayQueue Oct 05 14:00:10 volumio volumio[10224]: info: CorePlayQueue::saveQueue Oct 05 14:00:10 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:10 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:10 volumio volumio[10224]: info: CoreCommandRouter::volumioPushQueue Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: error: updateQueue error: null Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:10 volumio volumio[10224]: info: Starting UPNP Playback Oct 05 14:00:10 volumio volumio[10224]: info: Preparing playback through UPNP Oct 05 14:00:10 volumio volumio[10224]: info: CoreCommandRouter::volumioGetState Oct 05 14:00:10 volumio volumio[10224]: info: CorePlayQueue::getTrack 0 Oct 05 14:00:10 volumio volumio[10224]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 3ms Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:10 volumio volumio[10224]: info: Oct 05 14:00:10 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:10 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:10 volumio volumio[10224]: info: ------------------------------ 1ms Oct 05 14:00:15 volumio dhcpcd[1011]: eth0: adding route to 192.168.3.0/24 Oct 05 14:00:15 volumio dhcpcd[1011]: eth0: adding default route via 192.168.3.101 Oct 05 14:00:15 volumio dhcpcd[1011]: eth0: ipv4_addroute: File exists Oct 05 14:00:15 volumio dhcpcd[1011]: eth0: removing route to 192.168.3.0/24 Oct 05 14:00:17 volumio volumio[10224]: info: Oct 05 14:00:17 volumio volumio[10224]: ---------------------------- MPD announces state update: player Oct 05 14:00:17 volumio volumio[10224]: info: ControllerMpd::getState Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand status Oct 05 14:00:17 volumio volumio[10224]: info: Oct 05 14:00:17 volumio volumio[10224]: ---------------------------- MPD announces state update: player Oct 05 14:00:17 volumio volumio[10224]: info: ControllerMpd::getState Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand status Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::parseState Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 14:00:17 volumio volumio[10224]: info: Oct 05 14:00:17 volumio volumio[10224]: ---------------------------- MPD announces system playlist update Oct 05 14:00:17 volumio volumio[10224]: info: Ignoring MPD Status Update Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::parseState Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::parseTrackInfo Oct 05 14:00:17 volumio volumio[10224]: info: ControllerMpd::pushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::servicePushState Oct 05 14:00:17 volumio volumio[10224]: In UPNP mode Oct 05 14:00:17 volumio volumio[10224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Little Brown Book","artist":"Duke Ellington","album":"In a Sentimental Mood","uri":"http://aqqmusic.tc.qq.com/F000003tdR8L1JbVVW.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=D93B8BA6B075BC3841226FFEA2F9C8D69C5EF2873B7276AED934F80EDDF624DC25978A4E5E6CB3140C0DA70B56C752C203F95B6A52A7E1D9&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Oct 05 14:00:17 volumio volumio[10224]: verbose: CURRENT POSITION 0 Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::syncState stateService play Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::syncState currentStatus stop Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::pushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:17 volumio volumio[10224]: info: ------------------------------ 32ms Oct 05 14:00:17 volumio volumio[10224]: info: ------------------------------ 9ms Oct 05 14:00:17 volumio volumio[10224]: verbose: ControllerMpd::parseTrackInfo Oct 05 14:00:17 volumio volumio[10224]: info: ControllerMpd::pushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::servicePushState Oct 05 14:00:17 volumio volumio[10224]: In UPNP mode Oct 05 14:00:17 volumio volumio[10224]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":322,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"632 Kbps","isStreaming":false,"title":"My Little Brown Book","artist":"Duke Ellington","album":"In a Sentimental Mood","uri":"http://aqqmusic.tc.qq.com/F000003tdR8L1JbVVW.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=D93B8BA6B075BC3841226FFEA2F9C8D69C5EF2873B7276AED934F80EDDF624DC25978A4E5E6CB3140C0DA70B56C752C203F95B6A52A7E1D9&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Oct 05 14:00:17 volumio volumio[10224]: verbose: CURRENT POSITION 0 Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::syncState stateService play Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::syncState currentStatus play Oct 05 14:00:17 volumio volumio[10224]: info: Received an update from plugin. extracting info from payload Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::pushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::pushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::volumioPushState Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 05 14:00:17 volumio volumio[10224]: info: ------------------------------ 20ms Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::volumioGetQueue Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::getQueue Oct 05 14:00:17 volumio volumio[10224]: info: CorePlayQueue::getQueue Oct 05 14:00:17 volumio volumio[10224]: info: CoreCommandRouter::volumioGetQueue Oct 05 14:00:17 volumio volumio[10224]: info: CoreStateMachine::getQueue Oct 05 14:00:17 volumio volumio[10224]: info: CorePlayQueue::getQueue Oct 05 14:00:17 volumio volumio[10224]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bl%C3%BC%20Eyes/you%27d%20never%20know/0c14faab-610d-4c3d-9ba2-4ad250508f86.jpg' Oct 05 14:00:17 volumio volumio[10224]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Duke%20Ellington/In%20a%20Sentimental%20Mood/64e055fc-46fe-4050-803f-88da86873a3e.jpg' Oct 05 14:00:45 volumio dhcpcd[1011]: eth0: adding route to 192.168.3.0/24 Oct 05 14:00:45 volumio dhcpcd[1011]: eth0: adding default route via 192.168.3.101 Oct 05 14:00:45 volumio dhcpcd[1011]: eth0: ipv4_addroute: File exists Oct 05 14:00:45 volumio dhcpcd[1011]: eth0: removing route to 192.168.3.0/24 Oct 05 14:01:16 volumio dhcpcd[1011]: eth0: adding route to 192.168.3.0/24 Oct 05 14:01:16 volumio dhcpcd[1011]: eth0: adding default route via 192.168.3.101 Oct 05 14:01:16 volumio dhcpcd[1011]: eth0: ipv4_addroute: File exists Oct 05 14:01:16 volumio dhcpcd[1011]: eth0: removing route to 192.168.3.0/24 Oct 05 14:01:43 volumio volumio[10224]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 05 14:01:43 volumio volumio[10224]: { Error: connect ETIMEDOUT 168.143.171.93:443 Oct 05 14:01:43 volumio volumio[10224]: at Object._errnoException (util.js:1022:11) Oct 05 14:01:43 volumio volumio[10224]: at _exceptionWithHostPort (util.js:1044:20) Oct 05 14:01:43 volumio volumio[10224]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 05 14:01:43 volumio volumio[10224]: code: 'ETIMEDOUT', Oct 05 14:01:43 volumio volumio[10224]: errno: 'ETIMEDOUT', Oct 05 14:01:43 volumio volumio[10224]: syscall: 'connect', Oct 05 14:01:43 volumio volumio[10224]: address: '168.143.171.93', Oct 05 14:01:43 volumio volumio[10224]: port: 443 } Oct 05 14:01:43 volumio volumio[10224]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 05 14:01:43 volumio sudo[11125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-05 14:00 Oct 05 14:01:43 volumio sudo[11125]: 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="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 15:00:46 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="b3401e25b8d19b16b1038c2843d2deaf"