-- Logs begin at Sat 2024-04-27 20:53:54 CST, end at Sat 2024-04-27 21:03:55 CST. -- Apr 27 21:02:21 volumio volumio[695]: verbose: New Socket.io Connection to 192.168.8.8 from 192.168.8.7 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 4 Apr 27 21:02:21 volumio volumio[695]: verbose: New Socket.io Connection to 192.168.8.8 from 192.168.8.7 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 5 Apr 27 21:02:21 volumio volumio[695]: verbose: New Socket.io Connection to 192.168.8.8 from 192.168.8.7 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.5.1 Mobile/15E148 Safari/604.1 Total Clients: 6 Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 27 21:02:21 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::volumioGetQueue Apr 27 21:02:21 volumio volumio[695]: info: CoreStateMachine::getQueue Apr 27 21:02:21 volumio volumio[695]: info: CorePlayQueue::getQueue Apr 27 21:02:21 volumio volumio[695]: info: Listing playlists Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 21:02:21 volumio volumio[695]: info: Received Get System Info Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 21:02:21 volumio volumio[695]: info: Discovery: Getting this device information Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 27 21:02:21 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 21:02:21 volumio volumio[695]: info: CoreCommandRouter::volumioGetState Apr 27 21:02:21 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:02:24 volumio volumio[695]: info: VolumeController::SetAlsaVolume+ Apr 27 21:02:24 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:02:24 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:02:24 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:02:24 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:02:26 volumio volumio[695]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 27 21:02:26 volumio volumio[695]: info: Retrying Login Due to Network Error Apr 27 21:02:34 volumio volumio[695]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A-Lin/4df47803-2e35-4663-b742-33874cbf1f24.jpg' Apr 27 21:02:36 volumio volumio[695]: Searching all installed plugins Apr 27 21:02:36 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:02:36 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: , search Apr 27 21:02:36 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 27 21:02:36 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Apr 27 21:02:36 volumio volumio[695]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Apr 27 21:02:36 volumio volumio[695]: info: All search sources collected, pushing search results Apr 27 21:02:36 volumio volumio[695]: info: MyVolumio login type: Token Apr 27 21:03:06 volumio volumio[695]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 27 21:03:06 volumio volumio[695]: info: Retrying Login Due to Network Error Apr 27 21:03:08 volumio volumio[695]: Searching all installed plugins Apr 27 21:03:08 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 21:03:08 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: , search Apr 27 21:03:08 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 27 21:03:08 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Apr 27 21:03:08 volumio volumio[695]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Apr 27 21:03:08 volumio volumio[695]: info: All search sources collected, pushing search results Apr 27 21:03:16 volumio volumio[695]: info: MyVolumio login type: Token Apr 27 21:03:39 volumio volumio[695]: info: VolumeController::SetAlsaVolume- Apr 27 21:03:39 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:03:39 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:39 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:03:39 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:03:40 volumio volumio[695]: info: VolumeController::SetAlsaVolume- Apr 27 21:03:40 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:03:40 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:40 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:03:40 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:03:41 volumio volumio[695]: info: VolumeController::SetAlsaVolume- Apr 27 21:03:41 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:03:41 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:41 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:03:41 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:03:45 volumio volumio[695]: info: CoreCommandRouter::volumioPause Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::pause Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::stPlaybackTimer Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::servicePause Apr 27 21:03:45 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:45 volumio volumio[695]: info: CoreCommandRouter::servicePause Apr 27 21:03:45 volumio volumio[695]: info: ControllerMpd::pause Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::sendMpdCommand pause Apr 27 21:03:45 volumio volumio[695]: info: sendMpdCommand pause took 61 milliseconds Apr 27 21:03:45 volumio volumio[695]: info: Apr 27 21:03:45 volumio volumio[695]: ---------------------------- MPD announces state update: player Apr 27 21:03:45 volumio volumio[695]: info: ControllerMpd::getState Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::sendMpdCommand status Apr 27 21:03:45 volumio volumio[695]: info: Apr 27 21:03:45 volumio volumio[695]: ---------------------------- MPD announces state update: player Apr 27 21:03:45 volumio volumio[695]: info: ControllerMpd::getState Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::sendMpdCommand status Apr 27 21:03:45 volumio volumio[695]: info: sendMpdCommand status took 2 milliseconds Apr 27 21:03:45 volumio volumio[695]: info: sendMpdCommand status took 1 milliseconds Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::parseState Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::parseState Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 21:03:45 volumio volumio[695]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 21:03:45 volumio volumio[695]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::parseTrackInfo Apr 27 21:03:45 volumio volumio[695]: verbose: ControllerMpd::parseTrackInfo Apr 27 21:03:45 volumio volumio[695]: info: ControllerMpd::pushState Apr 27 21:03:45 volumio volumio[695]: info: CoreCommandRouter::servicePushState Apr 27 21:03:45 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:45 volumio volumio[695]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":120228,"duration":317,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"无止境的心痛","artist":"张学友","album":"友情歌岁月精选","uri":"USB/music/Music/【WAV、FLAC、ISO】/港台/张学友/友情歌歲月/04 无止境的心痛.wav","trackType":"wav"} Apr 27 21:03:45 volumio volumio[695]: verbose: CURRENT POSITION 0 Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::syncState stateService pause Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::syncState currentStatus pause Apr 27 21:03:45 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:03:45 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:45 volumio volumio[695]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 21:03:45 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:03:46 volumio volumio[695]: info: CoreStateMachine::stPlaybackTimer Apr 27 21:03:46 volumio volumio[695]: info: ControllerMpd::pushState Apr 27 21:03:46 volumio volumio[695]: info: CoreCommandRouter::servicePushState Apr 27 21:03:46 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:46 volumio volumio[695]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":120228,"duration":317,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"无止境的心痛","artist":"张学友","album":"友情歌岁月精选","uri":"USB/music/Music/【WAV、FLAC、ISO】/港台/张学友/友情歌歲月/04 无止境的心痛.wav","trackType":"wav"} Apr 27 21:03:46 volumio volumio[695]: verbose: CURRENT POSITION 0 Apr 27 21:03:46 volumio volumio[695]: info: CoreStateMachine::syncState stateService pause Apr 27 21:03:46 volumio volumio[695]: info: CoreStateMachine::syncState currentStatus pause Apr 27 21:03:46 volumio volumio[695]: info: CoreStateMachine::pushState Apr 27 21:03:46 volumio volumio[695]: info: CorePlayQueue::getTrack 0 Apr 27 21:03:46 volumio volumio[695]: info: CoreCommandRouter::volumioPushState Apr 27 21:03:46 volumio volumio[695]: info: CoreStateMachine::stPlaybackTimer Apr 27 21:03:46 volumio volumio[695]: info: ------------------------------ 18ms Apr 27 21:03:46 volumio volumio[695]: info: ------------------------------ 18ms Apr 27 21:03:46 volumio volumio[695]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 27 21:03:46 volumio volumio[695]: info: Retrying Login Due to Network Error Apr 27 21:03:55 volumio volumio[695]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 21:03:55 volumio volumio[695]: Error: connect ETIMEDOUT 118.193.240.37:80 Apr 27 21:03:55 volumio volumio[695]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 27 21:03:55 volumio volumio[695]: errno: -110, Apr 27 21:03:55 volumio volumio[695]: code: 'ETIMEDOUT', Apr 27 21:03:55 volumio volumio[695]: syscall: 'connect', Apr 27 21:03:55 volumio volumio[695]: address: '118.193.240.37', Apr 27 21:03:55 volumio volumio[695]: port: 80 Apr 27 21:03:55 volumio volumio[695]: } Apr 27 21:03:55 volumio volumio[695]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 21:03:55 volumio sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-27 21:02 Apr 27 21:03:55 volumio sudo[1299]: 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="68644ecc3d95554759c26a672c9f9845659ebf49" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="d1eed292e757ec0ddcc4830aa293d402cdfd9c92" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 06 Mar 2023 10:42:18 AM CET" VOLUMIO_VERSION="3.435" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cb521a82390d29f21453532486094e99"