-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2024-08-29 23:20:22 CST. -- Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 23:19:50 volumio volumio[11175]: info: Discovery: Getting this device information Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:19:50 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 23:19:50 volumio volumio[11175]: info: Discovery: Getting this device information Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:19:50 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:50 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 23:19:50 volumio volumio[11175]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sleep%20Token/05da3147-a579-4443-bb92-cfaeed804fe7.jpg' Aug 29 23:19:50 volumio volumio[11175]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/While%20She%20Sleeps/82a58d7c-f9c7-4603-a395-e00528dcd105.jpg' Aug 29 23:19:51 volumio volumio[11175]: verbose: New Socket.io Connection to 192.168.145.110:3000 from 192.168.145.19 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Aug 29 23:19:51 volumio volumio[11175]: verbose: New Socket.io Connection to 192.168.145.110 from 192.168.145.19 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::volumioGetVisibleSources Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:19:51 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::volumioGetQueue Aug 29 23:19:51 volumio volumio[11175]: info: CoreStateMachine::getQueue Aug 29 23:19:51 volumio volumio[11175]: info: CorePlayQueue::getQueue Aug 29 23:19:51 volumio volumio[11175]: info: Listing playlists Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 29 23:19:51 volumio volumio[11175]: info: Received Get System Info Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 23:19:51 volumio volumio[11175]: info: Discovery: Getting this device information Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:19:51 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:19:51 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:51 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::volumioPause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::stPlaybackTimer Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::servicePause Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::servicePause Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::pause Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand pause Aug 29 23:19:52 volumio volumio[11175]: info: Aug 29 23:19:52 volumio volumio[11175]: ---------------------------- MPD announces state update: player Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand pause took 1 milliseconds Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::getState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand status Aug 29 23:19:52 volumio volumio[11175]: info: Aug 29 23:19:52 volumio volumio[11175]: ---------------------------- MPD announces state update: player Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::getState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand status Aug 29 23:19:52 volumio volumio[11175]: info: Aug 29 23:19:52 volumio volumio[11175]: ---------------------------- MPD announces state update: player Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::getState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand status Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand status took 3 milliseconds Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand status took 2 milliseconds Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand status took 1 milliseconds Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseState Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 23:19:52 volumio volumio[11175]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseTrackInfo Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseTrackInfo Aug 29 23:19:52 volumio volumio[11175]: verbose: ControllerMpd::parseTrackInfo Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::servicePushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97485,"duration":304,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1218 Kbps","isStreaming":false,"title":"Chokehold","artist":"Sleep Token","album":"Take Me Back To Eden (24bit-44.1kHz)","uri":"USB/FLACs_750G/Music/Sleep Token/2023 - Take Me Back To Eden (24bit-44.1kHz)/01 Chokehold.flac","trackType":"flac"} Aug 29 23:19:52 volumio volumio[11175]: verbose: CURRENT POSITION 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState stateService pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState currentStatus pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::volumioPushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::stPlaybackTimer Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::servicePushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97485,"duration":304,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1218 Kbps","isStreaming":false,"title":"Chokehold","artist":"Sleep Token","album":"Take Me Back To Eden (24bit-44.1kHz)","uri":"USB/FLACs_750G/Music/Sleep Token/2023 - Take Me Back To Eden (24bit-44.1kHz)/01 Chokehold.flac","trackType":"flac"} Aug 29 23:19:52 volumio volumio[11175]: verbose: CURRENT POSITION 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState stateService pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState currentStatus pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::volumioPushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::stPlaybackTimer Aug 29 23:19:52 volumio volumio[11175]: info: ControllerMpd::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::servicePushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97485,"duration":304,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1218 Kbps","isStreaming":false,"title":"Chokehold","artist":"Sleep Token","album":"Take Me Back To Eden (24bit-44.1kHz)","uri":"USB/FLACs_750G/Music/Sleep Token/2023 - Take Me Back To Eden (24bit-44.1kHz)/01 Chokehold.flac","trackType":"flac"} Aug 29 23:19:52 volumio volumio[11175]: verbose: CURRENT POSITION 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState stateService pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::syncState currentStatus pause Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::pushState Aug 29 23:19:52 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:19:52 volumio volumio[11175]: info: CoreCommandRouter::volumioPushState Aug 29 23:19:52 volumio volumio[11175]: info: CoreStateMachine::stPlaybackTimer Aug 29 23:19:52 volumio volumio[11175]: info: ------------------------------ 25ms Aug 29 23:19:52 volumio volumio[11175]: info: ------------------------------ 24ms Aug 29 23:19:52 volumio volumio[11175]: info: ------------------------------ 23ms Aug 29 23:20:06 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 23:20:06 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 23:20:06 volumio volumio[11175]: info: Discovery: Getting this device information Aug 29 23:20:06 volumio volumio[11175]: info: CoreCommandRouter::volumioGetState Aug 29 23:20:06 volumio volumio[11175]: info: CorePlayQueue::getTrack 0 Aug 29 23:20:06 volumio volumio[11175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 23:20:22 volumio volumio[11175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 23:20:22 volumio volumio[11175]: Error: connect ETIMEDOUT 199.59.148.222:80 Aug 29 23:20:22 volumio volumio[11175]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 29 23:20:22 volumio volumio[11175]: errno: -110, Aug 29 23:20:22 volumio volumio[11175]: code: 'ETIMEDOUT', Aug 29 23:20:22 volumio volumio[11175]: syscall: 'connect', Aug 29 23:20:22 volumio volumio[11175]: address: '199.59.148.222', Aug 29 23:20:22 volumio volumio[11175]: port: 80 Aug 29 23:20:22 volumio volumio[11175]: } Aug 29 23:20:22 volumio volumio[11175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 23:20:22 volumio sudo[11994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-29 23:19 Aug 29 23:20:22 volumio sudo[11994]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"