-- Logs begin at Wed 2024-10-02 06:14:40 HKT, end at Thu 2024-10-03 12:50:41 HKT. -- Oct 03 12:49:00 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:06 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:11 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:17 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:22 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:28 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:34 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:39 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:45 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:50 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:56 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::volumioStop Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::stop Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::stPlaybackTimer Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::updateTrackBlock Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrackBlock Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::volumioPushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::serviceStop Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::serviceStop Oct 03 12:49:59 volumiopi volumio[25900]: info: [1727930999224] ControllerWebradio::stop Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand stop Oct 03 12:49:59 volumiopi volumio[25900]: info: Oct 03 12:49:59 volumiopi volumio[25900]: ---------------------------- MPD announces state update: player Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand stop took 12 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::getState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand status Oct 03 12:49:59 volumiopi volumio[25900]: info: Oct 03 12:49:59 volumiopi volumio[25900]: ---------------------------- MPD announces state update: player Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::getState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand status Oct 03 12:49:59 volumiopi volumio[25900]: info: Oct 03 12:49:59 volumiopi volumio[25900]: ---------------------------- MPD announces state update: player Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::getState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand status Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand status took 5 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand status took 3 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand status took 2 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseState Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseTrackInfo Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseTrackInfo Oct 03 12:49:59 volumiopi volumio[25900]: verbose: ControllerMpd::parseTrackInfo Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::servicePushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::volumioPushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::servicePushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::volumioPushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 03 12:49:59 volumiopi volumio[25900]: info: ControllerMpd::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::servicePushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreStateMachine::pushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: CoreCommandRouter::volumioPushState Oct 03 12:49:59 volumiopi volumio[25900]: info: CorePlayQueue::getTrack 0 Oct 03 12:49:59 volumiopi volumio[25900]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 03 12:49:59 volumiopi volumio[25900]: info: ------------------------------ 41ms Oct 03 12:49:59 volumiopi volumio[25900]: info: ------------------------------ 39ms Oct 03 12:49:59 volumiopi volumio[25900]: info: ------------------------------ 38ms Oct 03 12:50:01 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:07 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:12 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:18 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:23 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:29 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:35 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:40 volumiopi volumio[25900]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 12:50:40 volumiopi volumio[25900]: Error: connect ETIMEDOUT 31.13.75.12:80 Oct 03 12:50:40 volumiopi volumio[25900]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 03 12:50:40 volumiopi volumio[25900]: errno: -110, Oct 03 12:50:40 volumiopi volumio[25900]: code: 'ETIMEDOUT', Oct 03 12:50:40 volumiopi volumio[25900]: syscall: 'connect', Oct 03 12:50:40 volumiopi volumio[25900]: address: '31.13.75.12', Oct 03 12:50:40 volumiopi volumio[25900]: port: 80 Oct 03 12:50:40 volumiopi volumio[25900]: } Oct 03 12:50:40 volumiopi volumio[25900]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 12:50:40 volumiopi wpa_supplicant[781]: wlan0: Failed to initiate sched scan Oct 03 12:50:41 volumiopi sudo[27555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 12:49 Oct 03 12:50:41 volumiopi sudo[27555]: 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"