-- Logs begin at Thu 2020-09-24 20:57:32 UTC, end at Tue 2024-10-29 12:13:30 UTC. -- Oct 29 12:12:46 volumio hotspot[1028]: wlan0: STA 82:e2:76:d9:1b:2b IEEE 802.11: associated Oct 29 12:12:46 volumio hostapd[1070]: wlan0: STA 82:e2:76:d9:1b:2b IEEE 802.11: associated Oct 29 12:12:46 volumio hotspot[1028]: wlan0: AP-STA-CONNECTED 82:e2:76:d9:1b:2b Oct 29 12:12:46 volumio hostapd[1070]: wlan0: STA 82:e2:76:d9:1b:2b RADIUS: starting accounting session DA348269B8A34E45 Oct 29 12:12:46 volumio hostapd[1070]: wlan0: STA 82:e2:76:d9:1b:2b WPA: pairwise key handshake completed (RSN) Oct 29 12:12:46 volumio hotspot[1028]: wlan0: STA 82:e2:76:d9:1b:2b RADIUS: starting accounting session DA348269B8A34E45 Oct 29 12:12:46 volumio hotspot[1028]: wlan0: STA 82:e2:76:d9:1b:2b WPA: pairwise key handshake completed (RSN) Oct 29 12:12:46 volumio dhcpd[1048]: DHCPDISCOVER from 82:e2:76:d9:1b:2b via wlan0 Oct 29 12:12:47 volumio dhcpd[1048]: DHCPOFFER on 192.168.211.2 to 82:e2:76:d9:1b:2b (NAM-AL00) via wlan0 Oct 29 12:12:47 volumio dhcpd[1048]: DHCPDISCOVER from 82:e2:76:d9:1b:2b (NAM-AL00) via wlan0 Oct 29 12:12:47 volumio dhcpd[1048]: DHCPOFFER on 192.168.211.2 to 82:e2:76:d9:1b:2b (NAM-AL00) via wlan0 Oct 29 12:12:47 volumio dhcpd[1048]: DHCPREQUEST for 192.168.211.2 (192.168.211.1) from 82:e2:76:d9:1b:2b (NAM-AL00) via wlan0 Oct 29 12:12:47 volumio dhcpd[1048]: DHCPACK on 192.168.211.2 to 82:e2:76:d9:1b:2b (NAM-AL00) via wlan0 Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 12:12:53 volumio volumio[1032]: info: Discovery: Getting this device information Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Oct 29 12:12:53 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 29 12:12:53 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 29 12:12:54 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Oct 29 12:12:54 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:12:54 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 12:12:54 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 12:12:55 volumio kernel: Under-voltage detected! (0x00050005) Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 12:12:57 volumio volumio[1032]: info: Discovery: Getting this device information Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Oct 29 12:12:57 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 29 12:12:57 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 29 12:12:58 volumio sudo[1587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 12:12:58 volumio sudo[1587]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:12:58 volumio sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 12:12:58 volumio sudo[1587]: pam_unix(sudo:session): session closed for user root Oct 29 12:12:58 volumio sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:12:58 volumio sudo[1589]: pam_unix(sudo:session): session closed for user root Oct 29 12:13:00 volumio volumio[1032]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Soler/Canto/2440463c-b8ba-485f-9bfc-eb84faeb3aa5.jpg' Oct 29 12:13:00 volumio volumio[1032]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Soler/Canto/2440463c-b8ba-485f-9bfc-eb84faeb3aa5.jpg' Oct 29 12:13:01 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 12:13:01 volumio sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:13:01 volumio sudo[1613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 12:13:01 volumio sudo[1611]: pam_unix(sudo:session): session closed for user root Oct 29 12:13:01 volumio sudo[1613]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:13:01 volumio sudo[1613]: pam_unix(sudo:session): session closed for user root Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Oct 29 12:13:02 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 12:13:02 volumio volumio[1032]: info: Listing playlists Oct 29 12:13:02 volumio sudo[1631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 12:13:02 volumio sudo[1631]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:13:02 volumio sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 12:13:02 volumio sudo[1631]: pam_unix(sudo:session): session closed for user root Oct 29 12:13:02 volumio sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 12:13:02 volumio sudo[1633]: pam_unix(sudo:session): session closed for user root Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 12:13:02 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 12:13:02 volumio volumio[1032]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Soler/Canto/2440463c-b8ba-485f-9bfc-eb84faeb3aa5.jpg' Oct 29 12:13:03 volumio volumio[1032]: info: CoreCommandRouter::volumioGetState Oct 29 12:13:03 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::volumioPlay Oct 29 12:13:04 volumio volumio[1032]: UNSET VOLATILE Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::play index undefined Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::startPlaybackTimer Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::clearAddPlayTracks USB/A4FB-0C28/03（修改）经典怀旧金曲/020.风的季节-Soler.mp3 Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 12:13:04 volumio volumio[1032]: info: Oct 29 12:13:04 volumio volumio[1032]: ---------------------------- MPD announces system playlist update Oct 29 12:13:04 volumio volumio[1032]: info: Ignoring MPD Status Update Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand add "USB/A4FB-0C28/03（修改）经典怀旧金曲/020.风的季节-Soler.mp3" Oct 29 12:13:04 volumio volumio[1032]: error: updateQueue error: null Oct 29 12:13:04 volumio volumio[1032]: info: Oct 29 12:13:04 volumio volumio[1032]: ---------------------------- MPD announces system playlist update Oct 29 12:13:04 volumio volumio[1032]: info: Ignoring MPD Status Update Oct 29 12:13:04 volumio volumio[1032]: info: ------------------------------ 7ms Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand play Oct 29 12:13:04 volumio volumio[1032]: info: ------------------------------ 6ms Oct 29 12:13:04 volumio volumio[1032]: info: Oct 29 12:13:04 volumio volumio[1032]: ---------------------------- MPD announces state update: player Oct 29 12:13:04 volumio volumio[1032]: info: ControllerMpd::getState Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand status Oct 29 12:13:04 volumio volumio[1032]: info: Oct 29 12:13:04 volumio volumio[1032]: ---------------------------- MPD announces state update: player Oct 29 12:13:04 volumio volumio[1032]: info: ControllerMpd::getState Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand status Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::parseState Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::parseState Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::parseTrackInfo Oct 29 12:13:04 volumio volumio[1032]: info: ControllerMpd::pushState Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::servicePushState Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"风的季节","artist":"Soler","album":"Canto","uri":"USB/A4FB-0C28/03（修改）经典怀旧金曲/020.风的季节-Soler.mp3","trackType":"mp3"} Oct 29 12:13:04 volumio volumio[1032]: verbose: CURRENT POSITION 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::syncState stateService play Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::syncState currentStatus stop Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::pushState Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::volumioPushState Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 12:13:04 volumio volumio[1032]: info: ------------------------------ 37ms Oct 29 12:13:04 volumio volumio[1032]: verbose: ControllerMpd::parseTrackInfo Oct 29 12:13:04 volumio volumio[1032]: info: ControllerMpd::pushState Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::servicePushState Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"风的季节","artist":"Soler","album":"Canto","uri":"USB/A4FB-0C28/03（修改）经典怀旧金曲/020.风的季节-Soler.mp3","trackType":"mp3"} Oct 29 12:13:04 volumio volumio[1032]: verbose: CURRENT POSITION 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::syncState stateService play Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::syncState currentStatus play Oct 29 12:13:04 volumio volumio[1032]: info: Received an update from plugin. extracting info from payload Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::pushState Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::volumioPushState Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 12:13:04 volumio volumio[1032]: info: CoreStateMachine::pushState Oct 29 12:13:04 volumio volumio[1032]: info: CorePlayQueue::getTrack 0 Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::volumioPushState Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 12:13:04 volumio volumio[1032]: info: ------------------------------ 57ms Oct 29 12:13:04 volumio volumio[1032]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Soler/Canto/2440463c-b8ba-485f-9bfc-eb84faeb3aa5.jpg' Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 12:13:04 volumio volumio[1032]: info: Listing playlists Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 12:13:04 volumio volumio[1032]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Soler/Canto/2440463c-b8ba-485f-9bfc-eb84faeb3aa5.jpg' Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 12:13:04 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 12:13:07 volumio kernel: Voltage normalised (0x00000000) Oct 29 12:13:17 volumio volumio[1032]: info: CoreCommandRouter::volumioGetQueue Oct 29 12:13:17 volumio volumio[1032]: info: CoreStateMachine::getQueue Oct 29 12:13:17 volumio volumio[1032]: info: CorePlayQueue::getQueue Oct 29 12:13:21 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 12:13:22 volumio volumio[1032]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 29 12:13:29 volumio volumio[1032]: error: Cannot download Available plugins list: Error: ETIMEDOUT Oct 29 12:13:29 volumio volumio[1032]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 12:13:29 volumio volumio[1032]: { Error: connect ETIMEDOUT 104.244.46.17:443 Oct 29 12:13:30 volumio volumio[1032]: at Object._errnoException (util.js:1022:11) Oct 29 12:13:30 volumio volumio[1032]: at _exceptionWithHostPort (util.js:1044:20) Oct 29 12:13:30 volumio volumio[1032]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 29 12:13:30 volumio volumio[1032]: code: 'ETIMEDOUT', Oct 29 12:13:30 volumio volumio[1032]: errno: 'ETIMEDOUT', Oct 29 12:13:30 volumio volumio[1032]: syscall: 'connect', Oct 29 12:13:30 volumio volumio[1032]: address: '104.244.46.17', Oct 29 12:13:30 volumio volumio[1032]: port: 443 } Oct 29 12:13:30 volumio volumio[1032]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 12:13:30 volumio sudo[1740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-29 12:12 Oct 29 12:13:30 volumio sudo[1740]: 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"