-- Logs begin at Thu 2020-09-24 21:02:04 UTC, end at Fri 2024-10-11 00:50:53 UTC. -- Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: associated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: associated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA 6a:92:83:93:e6:36 RADIUS: starting accounting session 6E0887B750573EF1 Oct 11 00:49:41 volumio hotspot[1169]: wlan0: AP-STA-CONNECTED 6a:92:83:93:e6:36 Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA 6a:92:83:93:e6:36 RADIUS: starting accounting session 6E0887B750573EF1 Oct 11 00:49:41 volumio dhcpd[1190]: DHCPDISCOVER from 6a:92:83:93:e6:36 via wlan0 Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hotspot[1169]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:41 volumio hostapd[1202]: wlan0: STA fe:21:d8:30:78:57 IEEE 802.11: disassociated Oct 11 00:49:42 volumio dhcpd[1190]: DHCPOFFER on 192.168.211.70 to 6a:92:83:93:e6:36 via wlan0 Oct 11 00:49:43 volumio dhcpd[1190]: DHCPREQUEST for 192.168.211.70 (192.168.211.1) from 6a:92:83:93:e6:36 via wlan0 Oct 11 00:49:43 volumio dhcpd[1190]: DHCPACK on 192.168.211.70 to 6a:92:83:93:e6:36 via wlan0 Oct 11 00:49:45 volumio dnsmasq[1175]: reading /etc/resolv.conf Oct 11 00:49:45 volumio dnsmasq[1175]: using nameserver 208.67.222.222#53 Oct 11 00:49:45 volumio dnsmasq[1175]: using nameserver 208.67.220.220#53 Oct 11 00:49:45 volumio dnsmasq[1175]: using nameserver 192.168.8.1#53 Oct 11 00:49:46 volumio sudo[2153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 00:49:46 volumio sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 00:49:46 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:46 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:46 volumio sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:46 volumio sudo[2155]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:47 volumio sudo[2173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 00:49:47 volumio sudo[2173]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:47 volumio sudo[2176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 00:49:47 volumio sudo[2173]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:47 volumio sudo[2176]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:47 volumio sudo[2176]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::volumioGetState Oct 11 00:49:47 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 00:49:47 volumio volumio[1173]: info: Listing playlists Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 11 00:49:47 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 00:49:49 volumio volumio[1173]: info: CoreCommandRouter::volumioGetQueue Oct 11 00:49:49 volumio volumio[1173]: info: CoreStateMachine::getQueue Oct 11 00:49:49 volumio volumio[1173]: info: CorePlayQueue::getQueue Oct 11 00:49:54 volumio volumio[1173]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 00:49:54 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 11 00:49:54 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 11 00:49:54 volumio sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 11 00:49:54 volumio sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:54 volumio sudo[2220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 11 00:49:54 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2215]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 11 00:49:55 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2232]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 11 00:49:55 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 11 00:49:55 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 11 00:49:55 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 00:49:55 volumio sudo[2232]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 00:49:55 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 00:49:55 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2259]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 11 00:49:55 volumio sudo[2259]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio sudo[2272]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:55 volumio sudo[2272]: pam_unix(sudo:session): session closed for user root Oct 11 00:49:55 volumio kernel: brcmfmac: brcmf_vif_set_mgmt_ie: vndr ie set error : -52 Oct 11 00:49:55 volumio kernel: brcmfmac: brcmf_cfg80211_scan: scan error (-52) Oct 11 00:49:55 volumio volumio[1173]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 11 00:49:55 volumio volumio[1173]: wlan0 Interface doesn't support scanning : Invalid exchange Oct 11 00:49:55 volumio volumio[1173]: info: Cannot use regular scanning, forcing with ap-force Oct 11 00:49:55 volumio sudo[2293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 11 00:49:55 volumio sudo[2293]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 00:49:58 volumio sudo[2293]: pam_unix(sudo:session): session closed for user root Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:16 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:50:16 volumio volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:16 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:50:16 volumio volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 11 00:50:16 volumio shairport-sync[1393]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Oct 11 00:50:16 volumio shairport-sync[1393]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 11 00:50:16 volumio shairport-sync[1393]: Dload Upload Total Spent Left Speed Oct 11 00:50:16 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Oct 11 00:50:16 volumio shairport-sync[1393]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current Oct 11 00:50:16 volumio shairport-sync[1393]: Dload Upload Total Spent Left Speed Oct 11 00:50:16 volumio volumio[1173]: info: Oct 11 00:50:16 volumio volumio[1173]: ---------------------------- Client requests AirplayActive Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Oct 11 00:50:16 volumio shairport-sync[1393]: [155B blob data] Oct 11 00:50:16 volumio volumio[1173]: info: Airplay started streaming, receiving metadatas Oct 11 00:50:16 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::volumioStop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::stop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio volumio[1173]: UNSET VOLATILE Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio volumio[1173]: info: Airplay started streaming, receiving metadatas Oct 11 00:50:16 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::volumioStop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::stop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio volumio[1173]: UNSET VOLATILE Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio volumio[1173]: info: Oct 11 00:50:16 volumio volumio[1173]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 11 00:50:16 volumio volumio[1173]: info: Airplay playback start Oct 11 00:50:16 volumio volumio[1173]: info: CorePlayQueue::getTrack 0 Oct 11 00:50:16 volumio volumio[1173]: info: CoreCommandRouter::volumioStop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::stop Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio volumio[1173]: UNSET VOLATILE Oct 11 00:50:16 volumio volumio[1173]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 00:50:16 volumio shairport-sync[1393]: [136B blob data] Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:17 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::servicePushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreStateMachine::pushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::volumioPushState Oct 11 00:50:18 volumio volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 00:50:21 volumio hotspot[1169]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: disassociated Oct 11 00:50:21 volumio hostapd[1202]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: disassociated Oct 11 00:50:21 volumio hotspot[1169]: wlan0: AP-STA-DISCONNECTED 6a:92:83:93:e6:36 Oct 11 00:50:21 volumio hotspot[1169]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: disassociated Oct 11 00:50:21 volumio hostapd[1202]: wlan0: STA 6a:92:83:93:e6:36 IEEE 802.11: disassociated Oct 11 00:50:52 volumio volumio[1173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 00:50:52 volumio volumio[1173]: { Error: connect ETIMEDOUT 66.220.146.94:443 Oct 11 00:50:52 volumio volumio[1173]: at Object._errnoException (util.js:1022:11) Oct 11 00:50:52 volumio volumio[1173]: at _exceptionWithHostPort (util.js:1044:20) Oct 11 00:50:52 volumio volumio[1173]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 11 00:50:52 volumio volumio[1173]: code: 'ETIMEDOUT', Oct 11 00:50:52 volumio volumio[1173]: errno: 'ETIMEDOUT', Oct 11 00:50:52 volumio volumio[1173]: syscall: 'connect', Oct 11 00:50:52 volumio volumio[1173]: address: '66.220.146.94', Oct 11 00:50:52 volumio volumio[1173]: port: 443 } Oct 11 00:50:52 volumio volumio[1173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 00:50:53 volumio sudo[2449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-11 00:49 Oct 11 00:50:53 volumio sudo[2449]: 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"