-- Logs begin at Sat 2025-01-25 14:19:17 GMT, end at Sun 2025-05-04 05:03:11 GMT. -- May 04 05:02:10 volumio volumio[600]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8D%8A%E5%90%A8%E5%85%84%E5%BC%9F/a94d8dd6-dd57-484f-b862-4357515c6979.jpg' May 04 05:02:17 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 05:02:17 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 05:02:17 volumio volumio[600]: info: Discovery: Getting this device information May 04 05:02:17 volumio volumio[600]: info: CoreCommandRouter::volumioGetState May 04 05:02:17 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:17 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 05:02:17 volumio volumio[600]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BA%84%E5%BF%83%E5%A6%8D/eed7c4dd-85ef-4620-9491-b6de2dbb8dc6.jpg' May 04 05:02:19 volumio volumio[600]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BA%91%E6%9C%B5/cada590d-2908-4873-bd95-1a90dbb1ab1a.jpg' May 04 05:02:27 volumio kernel: usb 2-5: new full-speed USB device number 3 using ohci-pci May 04 05:02:28 volumio kernel: usb 2-5: New USB device found, idVendor=0a12, idProduct=0001, bcdDevice=88.91 May 04 05:02:28 volumio kernel: usb 2-5: New USB device strings: Mfr=0, Product=2, SerialNumber=0 May 04 05:02:28 volumio kernel: usb 2-5: Product: BT DONGLE10 May 04 05:02:28 volumio kernel: usbcore: registered new interface driver btusb May 04 05:02:28 volumio kernel: Bluetooth: hci0: CSR: Setting up dongle with HCI ver=12 rev=0201 May 04 05:02:28 volumio kernel: Bluetooth: hci0: LMP ver=12 subver=0201; manufacturer=10 May 04 05:02:28 volumio kernel: Bluetooth: hci0: CSR: Unbranded CSR clone detected; adding workarounds and force-suspending once... May 04 05:02:29 volumio kernel: Bluetooth: hci0: HCI Delete Stored Link Key command is advertised, but not supported. May 04 05:02:29 volumio kernel: Bluetooth: hci0: HCI Read Default Erroneous Data Reporting command is advertised, but not supported. May 04 05:02:29 volumio kernel: Bluetooth: hci0: HCI Set Event Filter command not supported. May 04 05:02:29 volumio kernel: Bluetooth: MGMT ver 1.22 May 04 05:02:29 volumio systemd[1]: Reached target Bluetooth. May 04 05:02:29 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... May 04 05:02:31 volumio systemd[1]: Started Load/Save RF Kill Switch Status. May 04 05:02:32 volumio startx[602]: (EE) client bug: timer event2 debounce: offset negative (-146ms) May 04 05:02:32 volumio startx[602]: (EE) client bug: timer event2 debounce: offset negative (-486ms) May 04 05:02:32 volumio startx[602]: (EE) client bug: timer event2 debounce short: offset negative (-499ms) May 04 05:02:35 volumio volumio[600]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/GooGoo/651023c7-27e7-42c4-8d53-2f4708cc6373.jpg' May 04 05:02:36 volumio systemd[1]: systemd-rfkill.service: Succeeded. May 04 05:02:43 volumio kernel: perf: interrupt took too long (2512 > 2500), lowering kernel.perf_event_max_sample_rate to 79500 May 04 05:02:44 volumio volumio[600]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 05:02:44 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 05:02:47 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 04 05:02:51 volumio volumio[600]: info: Received Get System Version May 04 05:02:51 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 04 05:02:54 volumio volumio[600]: info: CoreCommandRouter::volumioPause May 04 05:02:54 volumio volumio[600]: info: CoreStateMachine::pause May 04 05:02:54 volumio volumio[600]: info: CoreStateMachine::stPlaybackTimer May 04 05:02:54 volumio volumio[600]: info: CoreStateMachine::servicePause May 04 05:02:54 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:54 volumio volumio[600]: info: CoreCommandRouter::servicePause May 04 05:02:54 volumio volumio[600]: info: ControllerMpd::pause May 04 05:02:54 volumio volumio[600]: verbose: ControllerMpd::sendMpdCommand pause May 04 05:02:55 volumio volumio[600]: info: May 04 05:02:55 volumio volumio[600]: ---------------------------- MPD announces state update: player May 04 05:02:55 volumio volumio[600]: info: sendMpdCommand pause took 104 milliseconds May 04 05:02:55 volumio volumio[600]: info: ControllerMpd::getState May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::sendMpdCommand status May 04 05:02:55 volumio volumio[600]: info: May 04 05:02:55 volumio volumio[600]: ---------------------------- MPD announces state update: player May 04 05:02:55 volumio volumio[600]: info: ControllerMpd::getState May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::sendMpdCommand status May 04 05:02:55 volumio volumio[600]: info: sendMpdCommand status took 46 milliseconds May 04 05:02:55 volumio volumio[600]: info: sendMpdCommand status took 29 milliseconds May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::parseState May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::parseState May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 05:02:55 volumio volumio[600]: info: sendMpdCommand playlistinfo took 35 milliseconds May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::parseTrackInfo May 04 05:02:55 volumio volumio[600]: info: ControllerMpd::pushState May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::servicePushState May 04 05:02:55 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:55 volumio volumio[600]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":69972,"duration":28382,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"【经典怀旧】106首经典老歌，70后的年少时代，70、80、90年代经典老歌大全_经典老歌100首怀 - 1.【经典怀旧】100首经典老歌，70后的年少时代，70、80、90年代经典老歌(Av350408632,P1).mp3","artist":null,"album":null,"uri":"NAS/Music/【经典怀旧】106首经典老歌，70后的年少时代，70、80、90年代经典老歌大全_经典老歌100首怀 - 1.【经典怀旧】100首经典老歌，70后的年少时代，70、80、90年代经典老歌(Av350408632,P1).mp3","trackType":"mp3"} May 04 05:02:55 volumio volumio[600]: verbose: CURRENT POSITION 2 May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::syncState stateService pause May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::syncState currentStatus pause May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::pushState May 04 05:02:55 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::volumioPushState May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::stPlaybackTimer May 04 05:02:55 volumio volumio[600]: info: ------------------------------ 205ms May 04 05:02:55 volumio volumio[600]: info: sendMpdCommand playlistinfo took 141 milliseconds May 04 05:02:55 volumio volumio[600]: verbose: ControllerMpd::parseTrackInfo May 04 05:02:55 volumio volumio[600]: info: ControllerMpd::pushState May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::servicePushState May 04 05:02:55 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:55 volumio volumio[600]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":69972,"duration":28382,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"【经典怀旧】106首经典老歌，70后的年少时代，70、80、90年代经典老歌大全_经典老歌100首怀 - 1.【经典怀旧】100首经典老歌，70后的年少时代，70、80、90年代经典老歌(Av350408632,P1).mp3","artist":null,"album":null,"uri":"NAS/Music/【经典怀旧】106首经典老歌，70后的年少时代，70、80、90年代经典老歌大全_经典老歌100首怀 - 1.【经典怀旧】100首经典老歌，70后的年少时代，70、80、90年代经典老歌(Av350408632,P1).mp3","trackType":"mp3"} May 04 05:02:55 volumio volumio[600]: verbose: CURRENT POSITION 2 May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::syncState stateService pause May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::syncState currentStatus pause May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::pushState May 04 05:02:55 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::volumioPushState May 04 05:02:55 volumio volumio[600]: info: CoreStateMachine::stPlaybackTimer May 04 05:02:55 volumio volumio[600]: info: ------------------------------ 233ms May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 05:02:55 volumio volumio[600]: info: Discovery: Getting this device information May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::volumioGetState May 04 05:02:55 volumio volumio[600]: info: CorePlayQueue::getTrack 2 May 04 05:02:55 volumio volumio[600]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 05:03:09 volumio volumio[600]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 05:03:09 volumio volumio[600]: Error: connect ETIMEDOUT 108.160.170.41:80 May 04 05:03:09 volumio volumio[600]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 04 05:03:09 volumio volumio[600]: errno: -110, May 04 05:03:09 volumio volumio[600]: code: 'ETIMEDOUT', May 04 05:03:09 volumio volumio[600]: syscall: 'connect', May 04 05:03:09 volumio volumio[600]: address: '108.160.170.41', May 04 05:03:09 volumio volumio[600]: port: 80 May 04 05:03:09 volumio volumio[600]: } May 04 05:03:09 volumio volumio[600]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 05:03:11 volumio sudo[3012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 05:02 May 04 05:03:11 volumio sudo[3012]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"