-- Logs begin at Sat 2024-10-19 13:18:27 UTC, end at Sat 2024-10-19 14:06:26 UTC. -- Oct 19 14:05:19 volumio dhcpcd[1009]: eth0: adding route to 192.168.3.0/24 Oct 19 14:05:19 volumio dhcpcd[1009]: eth0: adding default route via 192.168.3.101 Oct 19 14:05:19 volumio dhcpcd[1009]: eth0: ipv4_addroute: File exists Oct 19 14:05:19 volumio dhcpcd[1009]: eth0: removing route to 192.168.3.0/24 Oct 19 14:05:49 volumio dhcpcd[1009]: eth0: adding route to 192.168.3.0/24 Oct 19 14:05:49 volumio dhcpcd[1009]: eth0: adding default route via 192.168.3.101 Oct 19 14:05:49 volumio dhcpcd[1009]: eth0: ipv4_addroute: File exists Oct 19 14:05:49 volumio dhcpcd[1009]: eth0: removing route to 192.168.3.0/24 Oct 19 14:06:13 volumio volumio[9564]: info: Oct 19 14:06:13 volumio volumio[9564]: ---------------------------- MPD announces state update: player Oct 19 14:06:13 volumio volumio[9564]: info: ControllerMpd::getState Oct 19 14:06:13 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand status Oct 19 14:06:13 volumio volumio[9564]: verbose: ControllerMpd::parseState Oct 19 14:06:13 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 14:06:13 volumio volumio[9564]: verbose: ControllerMpd::parseTrackInfo Oct 19 14:06:13 volumio volumio[9564]: info: ControllerMpd::pushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::servicePushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::pushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:13 volumio volumio[9564]: info: CorePlayQueue::getTrack 0 Oct 19 14:06:13 volumio volumio[9564]: 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":"Re: Person I Knew (Live)","artist":"Bill Evans Trio","album":"1979","uri":"http://aqqmusic.tc.qq.com/F000001MHsN40Lp0Qp.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=DDE1B885C901DE0F537130A6D5AD8E0C68A62DEBD1C284C57C13D31CBFE1E27D9F44B864F39438D4C44B25BDA7192804CCF728FB7BF4520F&uin=1259438298&src=F000001TryVU0wyh8v.flac&redirect=1&fromtag=111114","trackType":""} Oct 19 14:06:13 volumio volumio[9564]: verbose: CURRENT POSITION 0 Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::syncState stateService stop Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::syncState currentStatus play Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::stPlaybackTimer Oct 19 14:06:13 volumio volumio[9564]: info: ------------------------------ 16ms Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioGetQueue Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::getQueue Oct 19 14:06:13 volumio volumio[9564]: info: CorePlayQueue::getQueue Oct 19 14:06:13 volumio volumio[9564]: info: Clearing queue after UPNP request Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::ClearQueue Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::stop Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 14:06:13 volumio volumio[9564]: UNSET VOLATILE Oct 19 14:06:13 volumio volumio[9564]: info: CorePlayQueue::clearPlayQueue Oct 19 14:06:13 volumio volumio[9564]: info: CorePlayQueue::saveQueue Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioPushQueue Oct 19 14:06:13 volumio volumio[9564]: info: Oct 19 14:06:13 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:13 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:13 volumio volumio[9564]: error: updateQueue error: null Oct 19 14:06:13 volumio volumio[9564]: info: ------------------------------ 2ms Oct 19 14:06:13 volumio volumio[9564]: info: Starting UPNP Playback Oct 19 14:06:13 volumio volumio[9564]: info: Preparing playback through UPNP Oct 19 14:06:13 volumio volumio[9564]: info: CoreCommandRouter::volumioGetState Oct 19 14:06:13 volumio volumio[9564]: info: CorePlayQueue::getTrack 0 Oct 19 14:06:13 volumio volumio[9564]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 3ms Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 1ms Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 1ms Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 0ms Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: Oct 19 14:06:14 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:14 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 2ms Oct 19 14:06:14 volumio volumio[9564]: info: ------------------------------ 2ms Oct 19 14:06:19 volumio dhcpcd[1009]: eth0: adding route to 192.168.3.0/24 Oct 19 14:06:19 volumio dhcpcd[1009]: eth0: adding default route via 192.168.3.101 Oct 19 14:06:19 volumio dhcpcd[1009]: eth0: ipv4_addroute: File exists Oct 19 14:06:19 volumio dhcpcd[1009]: eth0: removing route to 192.168.3.0/24 Oct 19 14:06:23 volumio volumio[9564]: info: Oct 19 14:06:23 volumio volumio[9564]: ---------------------------- MPD announces state update: player Oct 19 14:06:23 volumio volumio[9564]: info: ControllerMpd::getState Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand status Oct 19 14:06:23 volumio volumio[9564]: info: Oct 19 14:06:23 volumio volumio[9564]: ---------------------------- MPD announces system playlist update Oct 19 14:06:23 volumio volumio[9564]: info: Ignoring MPD Status Update Oct 19 14:06:23 volumio volumio[9564]: info: Oct 19 14:06:23 volumio volumio[9564]: ---------------------------- MPD announces state update: player Oct 19 14:06:23 volumio volumio[9564]: info: ControllerMpd::getState Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand status Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::parseState Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 14:06:23 volumio volumio[9564]: info: ------------------------------ 3ms Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::parseState Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::parseTrackInfo Oct 19 14:06:23 volumio volumio[9564]: info: ControllerMpd::pushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::servicePushState Oct 19 14:06:23 volumio volumio[9564]: In UPNP mode Oct 19 14:06:23 volumio volumio[9564]: verbose: STATE SERVICE {"status":"play","position":0,"seek":92,"duration":347,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"637 Kbps","isStreaming":false,"title":"Re: Person I Knew","artist":"Bill Evans Trio","album":"Moon Beams (Original Album plus Bonus Tracks)","uri":"http://aqqmusic.tc.qq.com/F000001xYeSF2jCBA5.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=51551CDD184CE37820ED970AB2011A2E9A597656286222BF73B2065FC4A84186C42C27372D5F412AC767208D6A61727E367E9BAEBD1EC2DA&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Oct 19 14:06:23 volumio volumio[9564]: verbose: CURRENT POSITION 0 Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::syncState stateService play Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::syncState currentStatus stop Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::pushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:23 volumio volumio[9564]: info: ------------------------------ 19ms Oct 19 14:06:23 volumio volumio[9564]: verbose: ControllerMpd::parseTrackInfo Oct 19 14:06:23 volumio volumio[9564]: info: ControllerMpd::pushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::servicePushState Oct 19 14:06:23 volumio volumio[9564]: In UPNP mode Oct 19 14:06:23 volumio volumio[9564]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":347,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"682 Kbps","isStreaming":false,"title":"Re: Person I Knew","artist":"Bill Evans Trio","album":"Moon Beams (Original Album plus Bonus Tracks)","uri":"http://aqqmusic.tc.qq.com/F000001xYeSF2jCBA5.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=51551CDD184CE37820ED970AB2011A2E9A597656286222BF73B2065FC4A84186C42C27372D5F412AC767208D6A61727E367E9BAEBD1EC2DA&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Oct 19 14:06:23 volumio volumio[9564]: verbose: CURRENT POSITION 0 Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::syncState stateService play Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::syncState currentStatus play Oct 19 14:06:23 volumio volumio[9564]: info: Received an update from plugin. extracting info from payload Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::pushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::pushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::volumioPushState Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 14:06:23 volumio volumio[9564]: info: ------------------------------ 34ms Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::volumioGetQueue Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::getQueue Oct 19 14:06:23 volumio volumio[9564]: info: CorePlayQueue::getQueue Oct 19 14:06:23 volumio volumio[9564]: info: CoreCommandRouter::volumioGetQueue Oct 19 14:06:23 volumio volumio[9564]: info: CoreStateMachine::getQueue Oct 19 14:06:23 volumio volumio[9564]: info: CorePlayQueue::getQueue Oct 19 14:06:23 volumio volumio[9564]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bill%20Evans%20Trio/1979/e4ab17e2-63ee-4403-a2b3-80d48992ce34.jpg' Oct 19 14:06:25 volumio volumio[9564]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 14:06:25 volumio volumio[9564]: { Error: connect ETIMEDOUT 162.125.2.6:443 Oct 19 14:06:25 volumio volumio[9564]: at Object._errnoException (util.js:1022:11) Oct 19 14:06:25 volumio volumio[9564]: at _exceptionWithHostPort (util.js:1044:20) Oct 19 14:06:25 volumio volumio[9564]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 19 14:06:25 volumio volumio[9564]: code: 'ETIMEDOUT', Oct 19 14:06:25 volumio volumio[9564]: errno: 'ETIMEDOUT', Oct 19 14:06:25 volumio volumio[9564]: syscall: 'connect', Oct 19 14:06:25 volumio volumio[9564]: address: '162.125.2.6', Oct 19 14:06:25 volumio volumio[9564]: port: 443 } Oct 19 14:06:25 volumio volumio[9564]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 14:06:26 volumio sudo[11145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 14:05 Oct 19 14:06:26 volumio sudo[11145]: 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"