-- Logs begin at Sun 2024-07-07 06:39:56 CST, end at Mon 2024-07-08 22:20:59 CST. -- Jul 08 22:19:57 volumio volumio[5104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 22:19:57 volumio volumio[5104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 22:19:57 volumio volumio[5104]: info: Discovery: Getting this device information Jul 08 22:19:57 volumio volumio[5104]: info: CoreCommandRouter::volumioGetState Jul 08 22:19:57 volumio volumio[5104]: info: CorePlayQueue::getTrack 0 Jul 08 22:19:57 volumio volumio[5104]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPlay Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::play index 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::stop Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::play index undefined Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::startPlaybackTimer Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::clearAddPlayTracks USB/h/Beyond逝去日子.wav Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand stop took 5 milliseconds Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand clear Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand clear took 5 milliseconds Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand add "USB/h/Beyond逝去日子.wav" Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: error: updateQueue error: null Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 17ms Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand add "USB/h/Beyond逝去日子.wav" took 12 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 12ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 10ms Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand play Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces system playlist update Jul 08 22:20:00 volumio volumio[5104]: info: Ignoring MPD Status Update Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 18ms Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand play took 12 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 11ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 8ms Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 28 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 11 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 7 milliseconds Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: Jul 08 22:20:00 volumio volumio[5104]: ---------------------------- MPD announces state update: player Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::getState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand status Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 24 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 11 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand status took 7 milliseconds Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseState Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus stop Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:20:00 volumio volumio[5104]: info: Received an update from plugin. extracting info from payload Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:20:00 volumio volumio[5104]: info: Received an update from plugin. extracting info from payload Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 117ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 146ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 129ms Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 93 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 87 milliseconds Jul 08 22:20:00 volumio volumio[5104]: info: sendMpdCommand playlistinfo took 87 milliseconds Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: verbose: ControllerMpd::parseTrackInfo Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:20:00 volumio volumio[5104]: info: Received an update from plugin. extracting info from payload Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:20:00 volumio volumio[5104]: info: Received an update from plugin. extracting info from payload Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: ControllerMpd::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::servicePushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beyond逝去日子.wav","artist":"???","album":null,"uri":"USB/h/Beyond逝去日子.wav","trackType":"wav"} Jul 08 22:20:00 volumio volumio[5104]: verbose: CURRENT POSITION 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState stateService play Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::syncState currentStatus play Jul 08 22:20:00 volumio volumio[5104]: info: Received an update from plugin. extracting info from payload Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: CoreStateMachine::pushState Jul 08 22:20:00 volumio volumio[5104]: info: CorePlayQueue::getTrack 23 Jul 08 22:20:00 volumio volumio[5104]: info: CoreCommandRouter::volumioPushState Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 226ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 209ms Jul 08 22:20:00 volumio volumio[5104]: info: ------------------------------ 206ms Jul 08 22:20:00 volumio volumio[5104]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F%3F/bd4ff7df-1a8b-4be8-ac09-49220851a34b.jpg' Jul 08 22:20:00 volumio volumio[5104]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F%3F/bd4ff7df-1a8b-4be8-ac09-49220851a34b.jpg' Jul 08 22:20:58 volumio volumio[5104]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:20:58 volumio volumio[5104]: Error: connect ETIMEDOUT 31.13.96.194:443 Jul 08 22:20:58 volumio volumio[5104]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 08 22:20:58 volumio volumio[5104]: errno: -110, Jul 08 22:20:58 volumio volumio[5104]: code: 'ETIMEDOUT', Jul 08 22:20:58 volumio volumio[5104]: syscall: 'connect', Jul 08 22:20:58 volumio volumio[5104]: address: '31.13.96.194', Jul 08 22:20:58 volumio volumio[5104]: port: 443 Jul 08 22:20:58 volumio volumio[5104]: } Jul 08 22:20:58 volumio volumio[5104]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 22:20:59 volumio sudo[5581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-08 22:19 Jul 08 22:20:59 volumio sudo[5581]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="6e682b9410d28f3874f90b2d7789db824a859264" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7c81f20187867c3bd55475ead0f12800fe93082c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 09 Jun 2024 12:13:35 AM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="nanopineo3-armbian" VOLUMIO_DEVICENAME="NanoPi Neo3" VOLUMIO_HASH="bc61f601bd3ddb6b22ceed4c6da0304b"