-- Logs begin at Wed 2025-05-28 22:28:42 UTC, end at Fri 2025-05-30 16:22:58 UTC. -- May 30 16:21:05 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:10 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 16:21:14 volumio volumio[13978]: info: Discovery: Getting this device information May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::volumioGetState May 30 16:21:14 volumio volumio[13978]: info: CorePlayQueue::getTrack 8 May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:21:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:21:16 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:21 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:26 volumio volumio[13978]: info: CorePlayQueue::getTrack 8 May 30 16:21:26 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:26 volumio volumio[13978]: info: Prefetching next song May 30 16:21:26 volumio volumio[13978]: info: DOING PREFETCH IN MPD May 30 16:21:26 volumio volumio[13978]: verbose: ControllerMpd::sendMpdCommand add "NAS/Nas/1yandex/Wallem - Харизма.mp3" May 30 16:21:26 volumio volumio[13978]: info: May 30 16:21:26 volumio volumio[13978]: ---------------------------- MPD announces system playlist update May 30 16:21:26 volumio volumio[13978]: info: Ignoring MPD Status Update May 30 16:21:26 volumio volumio[13978]: info: sendMpdCommand add "NAS/Nas/1yandex/Wallem - Харизма.mp3" took 5 milliseconds May 30 16:21:26 volumio volumio[13978]: verbose: ControllerMpd::sendMpdCommand consume 1 May 30 16:21:26 volumio volumio[13978]: info: ------------------------------ 78ms May 30 16:21:26 volumio volumio[13978]: info: sendMpdCommand consume 1 took 76 milliseconds May 30 16:21:27 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:31 volumio volumio[13978]: info: CoreStateMachine::startPlaybackTimer May 30 16:21:31 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:31 volumio volumio[13978]: info: May 30 16:21:31 volumio volumio[13978]: ---------------------------- MPD announces system playlist update May 30 16:21:31 volumio volumio[13978]: info: Ignoring MPD Status Update May 30 16:21:31 volumio volumio[13978]: info: May 30 16:21:31 volumio volumio[13978]: ---------------------------- MPD announces state update: player May 30 16:21:31 volumio volumio[13978]: info: ControllerMpd::getState May 30 16:21:31 volumio volumio[13978]: verbose: ControllerMpd::sendMpdCommand status May 30 16:21:31 volumio volumio[13978]: info: ------------------------------ 3ms May 30 16:21:31 volumio volumio[13978]: info: sendMpdCommand status took 2 milliseconds May 30 16:21:31 volumio volumio[13978]: verbose: ControllerMpd::parseState May 30 16:21:31 volumio volumio[13978]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 16:21:31 volumio volumio[13978]: info: sendMpdCommand playlistinfo took 1 milliseconds May 30 16:21:31 volumio volumio[13978]: verbose: ControllerMpd::parseTrackInfo May 30 16:21:31 volumio volumio[13978]: info: ControllerMpd::pushState May 30 16:21:31 volumio volumio[13978]: info: CoreCommandRouter::servicePushState May 30 16:21:31 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:31 volumio volumio[13978]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":136,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Харизма","artist":"Wallem","album":"Харизма","uri":"NAS/Nas/1yandex/Wallem - Харизма.mp3","trackType":"mp3"} May 30 16:21:31 volumio volumio[13978]: verbose: CURRENT POSITION 236 May 30 16:21:31 volumio volumio[13978]: info: CoreStateMachine::syncState stateService play May 30 16:21:31 volumio volumio[13978]: info: CoreStateMachine::syncState currentStatus play May 30 16:21:31 volumio volumio[13978]: info: Received an update from plugin. extracting info from payload May 30 16:21:31 volumio volumio[13978]: info: CoreStateMachine::pushState May 30 16:21:31 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:31 volumio volumio[13978]: info: CoreCommandRouter::volumioPushState May 30 16:21:31 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 16:21:31 volumio volumio[13978]: info: CoreStateMachine::pushState May 30 16:21:31 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:31 volumio volumio[13978]: info: CoreCommandRouter::volumioPushState May 30 16:21:31 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 16:21:31 volumio volumio[13978]: info: ------------------------------ 33ms May 30 16:21:32 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:38 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:43 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 16:21:44 volumio volumio[13978]: info: Discovery: Getting this device information May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::volumioGetState May 30 16:21:44 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:21:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:21:49 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:21:54 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:00 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:06 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:11 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 16:22:14 volumio volumio[13978]: info: Discovery: Getting this device information May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::volumioGetState May 30 16:22:14 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:14 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:17 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:22 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:28 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 16:22:29 volumio volumio[13978]: info: Discovery: Getting this device information May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::volumioGetState May 30 16:22:29 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:29 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:33 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:39 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:44 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 16:22:44 volumio volumio[13978]: info: Discovery: Getting this device information May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::volumioGetState May 30 16:22:44 volumio volumio[13978]: info: CorePlayQueue::getTrack 236 May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:44 volumio volumio[13978]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 30 16:22:50 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:55 volumio wpa_supplicant[1043]: wlan0: Failed to initiate sched scan May 30 16:22:58 volumio volumio[13978]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 16:22:58 volumio volumio[13978]: { Error: connect ETIMEDOUT 146.75.118.79:443 May 30 16:22:58 volumio volumio[13978]: at Object._errnoException (util.js:1022:11) May 30 16:22:58 volumio volumio[13978]: at _exceptionWithHostPort (util.js:1044:20) May 30 16:22:58 volumio volumio[13978]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 30 16:22:58 volumio volumio[13978]: code: 'ETIMEDOUT', May 30 16:22:58 volumio volumio[13978]: errno: 'ETIMEDOUT', May 30 16:22:58 volumio volumio[13978]: syscall: 'connect', May 30 16:22:58 volumio volumio[13978]: address: '146.75.118.79', May 30 16:22:58 volumio volumio[13978]: port: 443 } May 30 16:22:58 volumio volumio[13978]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 16:22:58 volumio sudo[3121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-30 16:21 May 30 16:22:58 volumio sudo[3121]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"