-- Logs begin at Wed 2024-10-23 19:39:29 HKT, end at Thu 2024-10-24 20:41:57 HKT. -- Oct 24 20:40:01 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:07 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:08 volumiopi volumio-remote-updater[535]: No test mode Oct 24 20:40:08 volumiopi volumio-remote-updater[535]: No alpha test mode Oct 24 20:40:08 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 24 20:40:12 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:18 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:20 volumiopi volumio[26562]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS



 

","title":"Update v3.757","updateavailable":true} Oct 24 20:40:20 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 24 20:40:23 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:29 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:34 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:40 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:45 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:51 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:56 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces system playlist update Oct 24 20:40:58 volumiopi volumio[26562]: info: Ignoring MPD Status Update Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces state update: player Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::getState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces system playlist update Oct 24 20:40:58 volumiopi volumio[26562]: info: Ignoring MPD Status Update Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces state update: player Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::getState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 9ms Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand status took 7 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 5ms Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand status took 4 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces system playlist update Oct 24 20:40:58 volumiopi volumio[26562]: info: Ignoring MPD Status Update Oct 24 20:40:58 volumiopi volumio[26562]: info: Oct 24 20:40:58 volumiopi volumio[26562]: ---------------------------- MPD announces state update: player Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::getState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 8ms Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand status took 6 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseState Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::servicePushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CorePlayQueue::getTrack 0 Oct 24 20:40:58 volumiopi volumio[26562]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73678,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Raul Midon - Ride on a Rainbow","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Oct 24 20:40:58 volumiopi volumio[26562]: verbose: CURRENT POSITION 0 Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState stateService play Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:40:58 volumiopi volumio[26562]: info: Received an update from plugin. extracting info from payload Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::servicePushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CorePlayQueue::getTrack 0 Oct 24 20:40:58 volumiopi volumio[26562]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73678,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Raul Midon - Ride on a Rainbow","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Oct 24 20:40:58 volumiopi volumio[26562]: verbose: CURRENT POSITION 0 Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState stateService play Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:40:58 volumiopi volumio[26562]: info: Received an update from plugin. extracting info from payload Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 63ms Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 60ms Oct 24 20:40:58 volumiopi volumio[26562]: info: sendMpdCommand playlistinfo took 42 milliseconds Oct 24 20:40:58 volumiopi volumio[26562]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:40:58 volumiopi volumio[26562]: info: ControllerMpd::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::servicePushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CorePlayQueue::getTrack 0 Oct 24 20:40:58 volumiopi volumio[26562]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73678,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Raul Midon - Ride on a Rainbow","artist":"Smooth Jazz - Tampa Bay","album":null,"uri":"http://server.webnetradio.net:5250/stream","trackType":""} Oct 24 20:40:58 volumiopi volumio[26562]: verbose: CURRENT POSITION 0 Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState stateService play Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:40:58 volumiopi volumio[26562]: info: Received an update from plugin. extracting info from payload Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:40:58 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:40:58 volumiopi volumio[26562]: info: ------------------------------ 78ms Oct 24 20:41:02 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:07 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:13 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:19 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:21 volumiopi volumio[26562]: info: VolumeController::SetAlsaVolume62 Oct 24 20:41:21 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:41:21 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:41:21 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:41:22 volumiopi volumio[26562]: info: VolumeController::SetAlsaVolume71 Oct 24 20:41:22 volumiopi volumio[26562]: info: CoreStateMachine::pushState Oct 24 20:41:22 volumiopi volumio[26562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:41:22 volumiopi volumio[26562]: info: CoreCommandRouter::volumioPushState Oct 24 20:41:24 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:30 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:35 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:41 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:46 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:52 volumiopi wpa_supplicant[829]: wlan0: Failed to initiate sched scan Oct 24 20:41:56 volumiopi volumio[26562]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:41:56 volumiopi volumio[26562]: Error: connect ETIMEDOUT 108.160.166.61:80 Oct 24 20:41:56 volumiopi volumio[26562]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 24 20:41:56 volumiopi volumio[26562]: errno: -110, Oct 24 20:41:56 volumiopi volumio[26562]: code: 'ETIMEDOUT', Oct 24 20:41:56 volumiopi volumio[26562]: syscall: 'connect', Oct 24 20:41:56 volumiopi volumio[26562]: address: '108.160.166.61', Oct 24 20:41:56 volumiopi volumio[26562]: port: 80 Oct 24 20:41:56 volumiopi volumio[26562]: } Oct 24 20:41:56 volumiopi volumio[26562]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:41:57 volumiopi sudo[26868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-24 20:40 Oct 24 20:41:57 volumiopi sudo[26868]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"