-- Logs begin at Sat 2024-04-20 12:44:58 CEST, end at Sat 2024-04-20 12:49:14 CEST. -- Apr 20 12:47:01 volumio volumio[626]: info: Discovery: Started advertising with name: Volumio Apr 20 12:47:01 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:47:01 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:47:01 volumio sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:01 volumio sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:01 volumio sudo[1577]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:06 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:47:06 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:47:06 volumio volumio[626]: info: Refreshing Cached IP Addresses Apr 20 12:47:06 volumio sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:47:06 volumio sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:06 volumio sudo[1585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:06 volumio sudo[1585]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:06 volumio sudo[1585]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:06 volumio sudo[1587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:06 volumio sudo[1587]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:06 volumio sudo[1583]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:06 volumio volumio[626]: error: Cannot kill upmpdcli Error: Command failed: /usr/bin/sudo /usr/bin/killall upmpdcli Apr 20 12:47:06 volumio volumio[626]: upmpdcli: no process found Apr 20 12:47:06 volumio sudo[1587]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:07 volumio volumio[626]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 4 Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::volumioGetVisibleSources Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:47:07 volumio volumio[626]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:07 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 20 12:47:07 volumio volumio[626]: info: Received Get System Info Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:47:07 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:07 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:07 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:07 volumio volumio[626]: info: Listing playlists Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 20 12:47:07 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 20 12:47:08 volumio sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 20 12:47:08 volumio sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:08 volumio sudo[1600]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:08 volumio sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1605]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:08 volumio sudo[1611]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:08 volumio sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:08 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1632]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 20 12:47:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 20 12:47:08 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:47:08 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 20 12:47:08 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio volumio[626]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 20 12:47:08 volumio volumio[626]: wlan0 Interface doesn't support scanning. Apr 20 12:47:08 volumio volumio[626]: info: Cannot use regular scanning, forcing with ap-force Apr 20 12:47:08 volumio sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 20 12:47:08 volumio sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:08 volumio sudo[1650]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:08 volumio volumio[626]: command failed: No such device (-19) Apr 20 12:47:08 volumio volumio[626]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 20 12:47:08 volumio volumio[626]: command failed: No such device (-19) Apr 20 12:47:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:47:09 volumio volumio[626]: info: Received Get System Info Apr 20 12:47:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:47:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:47:09 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:47:09 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:09 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:47:16 volumio sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:16 volumio sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:16 volumio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:16 volumio sudo[1656]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:16 volumio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:16 volumio sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 20 12:47:16 volumio sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:16 volumio sudo[1658]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:16 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 20 12:47:16 volumio sudo[1660]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:16 volumio volumio[626]: info: Upmpdcli Daemon Started Apr 20 12:47:17 volumio ntpd[602]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 20 12:47:19 volumio ntpd[602]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 20 12:47:19 volumio volumio[626]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Apr 20 12:47:19 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Apr 20 12:47:19 volumio sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 20 12:47:19 volumio sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:19 volumio sudo[1686]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:19 volumio sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 20 12:47:19 volumio sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:19 volumio sudo[1688]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:19 volumio volumio[626]: info: Permissions for /etc/network/interfaces set Apr 20 12:47:19 volumio volumio[626]: info: Restarting Wireless Network Apr 20 12:47:19 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:47:19 volumio volumio[626]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:47:19 volumio sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 20 12:47:19 volumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:19 volumio systemd[1]: Starting Wireless Services... Apr 20 12:47:19 volumio wireless.js[1693]: WIRELESS: No wireless interface, exiting Apr 20 12:47:19 volumio iw[1704]: command failed: No such device (-19) Apr 20 12:47:19 volumio iwconfig[1707]: Error for wireless request "Set Power Management" (8B2C) : Apr 20 12:47:19 volumio iwconfig[1707]: SET failed on device wlan0 ; No such device. Apr 20 12:47:19 volumio systemd[1]: wireless.service: Succeeded. Apr 20 12:47:19 volumio sudo[1691]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:19 volumio systemd[1]: Started Wireless Services. Apr 20 12:47:21 volumio ntpd[602]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 20 12:47:21 volumio ntpd[602]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 20 12:47:24 volumio volumio[626]: info: Discovery: Started advertising with name: Volumio Apr 20 12:47:24 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:47:24 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:47:24 volumio sudo[1722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:24 volumio sudo[1722]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:24 volumio sudo[1722]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:29 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:47:29 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:47:29 volumio volumio[626]: info: Refreshing Cached IP Addresses Apr 20 12:47:29 volumio sudo[1738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:47:29 volumio sudo[1738]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:29 volumio systemd[1]: upmpdcli.service: Main process exited, code=killed, status=15/TERM Apr 20 12:47:29 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:47:29 volumio sudo[1740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:29 volumio sudo[1738]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:29 volumio sudo[1740]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:30 volumio sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:30 volumio sudo[1740]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:30 volumio sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:30 volumio sudo[1742]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:30 volumio volumio[626]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 4 Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::volumioGetVisibleSources Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:47:30 volumio volumio[626]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:30 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 20 12:47:30 volumio volumio[626]: info: Received Get System Info Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:47:30 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:30 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:30 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:30 volumio volumio[626]: info: Listing playlists Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 20 12:47:30 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 20 12:47:31 volumio sudo[1751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 20 12:47:31 volumio sudo[1751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1751]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:31 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:31 volumio sudo[1763]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio sudo[1769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:47:31 volumio sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1763]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:31 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1769]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 20 12:47:31 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 20 12:47:31 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:31 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:47:31 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio sudo[1794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 20 12:47:31 volumio sudo[1794]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1794]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio volumio[626]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 20 12:47:31 volumio volumio[626]: wlan0 Interface doesn't support scanning. Apr 20 12:47:31 volumio volumio[626]: info: Cannot use regular scanning, forcing with ap-force Apr 20 12:47:31 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 20 12:47:31 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:31 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:31 volumio volumio[626]: command failed: No such device (-19) Apr 20 12:47:31 volumio volumio[626]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 20 12:47:31 volumio volumio[626]: command failed: No such device (-19) Apr 20 12:47:32 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:47:32 volumio volumio[626]: info: Received Get System Info Apr 20 12:47:32 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:47:32 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:47:32 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:47:32 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:47:32 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:32 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:47:40 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:47:40 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:40 volumio sudo[1809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:47:40 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:40 volumio sudo[1809]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:40 volumio sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 20 12:47:40 volumio sudo[1811]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:47:40 volumio sudo[1809]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:40 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 20 12:47:40 volumio sudo[1811]: pam_unix(sudo:session): session closed for user root Apr 20 12:47:40 volumio volumio[626]: info: Upmpdcli Daemon Started Apr 20 12:47:51 volumio kernel: usb 2-3: new high-speed USB device number 3 using xhci_hcd Apr 20 12:47:51 volumio kernel: usb 2-3: New USB device found, idVendor=0cf3, idProduct=7015, bcdDevice= 2.02 Apr 20 12:47:51 volumio kernel: usb 2-3: New USB device strings: Mfr=16, Product=32, SerialNumber=48 Apr 20 12:47:51 volumio kernel: usb 2-3: Product: UB95 Apr 20 12:47:51 volumio kernel: usb 2-3: Manufacturer: ATHEROS Apr 20 12:47:51 volumio kernel: usb 2-3: SerialNumber: 12345 Apr 20 12:47:51 volumio kernel: usb 2-3: ath9k_htc: Firmware ath9k_htc/htc_7010-1.4.0.fw requested Apr 20 12:47:51 volumio kernel: usbcore: registered new interface driver ath9k_htc Apr 20 12:47:51 volumio kernel: usb 2-3: ath9k_htc: Transferred FW: ath9k_htc/htc_7010-1.4.0.fw, size: 72812 Apr 20 12:47:51 volumio kernel: ath9k_htc 2-3:1.0: ath9k_htc: HTC initialized with 45 credits Apr 20 12:47:51 volumio kernel: snd_hda_intel 0000:00:1b.0: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj. Apr 20 12:47:52 volumio kernel: ath9k_htc 2-3:1.0: ath9k_htc: FW Version: 1.4 Apr 20 12:47:52 volumio kernel: ath9k_htc 2-3:1.0: FW RMW support: On Apr 20 12:47:52 volumio kernel: ath: EEPROM regdomain: 0x809c Apr 20 12:47:52 volumio kernel: ath: EEPROM indicates we should expect a country code Apr 20 12:47:52 volumio kernel: ath: doing EEPROM country->regdmn map search Apr 20 12:47:52 volumio kernel: ath: country maps to regdmn code: 0x52 Apr 20 12:47:52 volumio kernel: ath: Country alpha2 being used: CN Apr 20 12:47:52 volumio kernel: ath: Regpair used: 0x52 Apr 20 12:47:52 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 20 12:47:52 volumio systemd-udevd[1855]: Using default interface naming scheme 'v240'. Apr 20 12:47:52 volumio kernel: ieee80211 phy0: Atheros AR9287 Rev:2 Apr 20 12:47:52 volumio systemd-udevd[1855]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 20 12:47:52 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Apr 20 12:47:52 volumio dhcpcd[511]: wlan0: waiting for carrier Apr 20 12:47:52 volumio dhcpcd[511]: wlan0: carrier acquired Apr 20 12:47:52 volumio dhcpcd[511]: DUID 00:04:34:8b:4e:3c:ee:10:cf:e6:83:9e:e3:65:a7:3e:36:6d Apr 20 12:47:52 volumio dhcpcd[511]: wlan0: IAID fc:93:c6:3f Apr 20 12:47:52 volumio dhcpcd[511]: wlan0: adding address fe80::486f:4711:acf3:204f Apr 20 12:47:52 volumio dhcpcd[511]: ipv6_addaddr1: Permission denied Apr 20 12:47:52 volumio dhcpcd[511]: wlan0: carrier lost Apr 20 12:47:52 volumio systemd[1]: Found device TP-Link TL-WN821N v3 / TL-WN822N v2 802.11n [Atheros AR7010+AR9287]. Apr 20 12:47:52 volumio systemd[1]: Started ifup for wlan0. Apr 20 12:47:52 volumio sh[1887]: wlan0=wlan0 Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::volumioSeek Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::seek Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/2019 - zawialow Helsinki/02 - Helsinki.mp3","service":"mpd","name":"Helsinki","artist":"Daria Zawiałow","album":"Helsinki","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=895&web=Daria%20Zawia%C5%82ow/Helsinki/extralarge&path=%2FINTERNAL%2F2019%20-%20zawialow%20Helsinki&metadata=false","duration":229,"trackType":"mp3","samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2} Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::startPlaybackTimer Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: info: ControllerMpd::seek Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::pushState Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::volumioPushState Apr 20 12:47:55 volumio volumio[626]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 12:47:55 volumio volumio[626]: error: null Apr 20 12:47:55 volumio volumio[626]: info: Apr 20 12:47:55 volumio volumio[626]: ---------------------------- MPD announces state update: player Apr 20 12:47:55 volumio volumio[626]: info: ControllerMpd::getState Apr 20 12:47:55 volumio volumio[626]: verbose: ControllerMpd::sendMpdCommand status Apr 20 12:47:55 volumio volumio[626]: Upnp client error: Error: This socket has been ended by the other party Apr 20 12:47:55 volumio volumio[626]: info: sendMpdCommand status took 3 milliseconds Apr 20 12:47:55 volumio volumio[626]: verbose: ControllerMpd::parseState Apr 20 12:47:55 volumio volumio[626]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 12:47:55 volumio volumio[626]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 20 12:47:55 volumio volumio[626]: verbose: ControllerMpd::parseTrackInfo Apr 20 12:47:55 volumio volumio[626]: info: ControllerMpd::pushState Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::servicePushState Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: verbose: STATE SERVICE {"status":"play","position":0,"seek":74000,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Helsinki","artist":"Daria Zawiałow","album":"Helsinki","uri":"INTERNAL/2019 - zawialow Helsinki/02 - Helsinki.mp3","trackType":"mp3"} Apr 20 12:47:55 volumio volumio[626]: verbose: CURRENT POSITION 0 Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::syncState stateService play Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::syncState currentStatus play Apr 20 12:47:55 volumio volumio[626]: info: Received an update from plugin. extracting info from payload Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::pushState Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::volumioPushState Apr 20 12:47:55 volumio volumio[626]: info: CoreStateMachine::pushState Apr 20 12:47:55 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:47:55 volumio volumio[626]: info: CoreCommandRouter::volumioPushState Apr 20 12:47:55 volumio volumio[626]: info: ------------------------------ 26ms Apr 20 12:47:55 volumio volumio[626]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 12:47:55 volumio volumio[626]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - eq1: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Lowshelf Apr 20 12:47:56 volumio volumio[626]: freq: 185 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq2: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Peaking Apr 20 12:47:56 volumio volumio[626]: freq: 1300 Apr 20 12:47:56 volumio volumio[626]: q: 0.4 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq3: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Highshelf Apr 20 12:47:56 volumio volumio[626]: freq: 5500 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - eq1: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Lowshelf Apr 20 12:47:56 volumio volumio[626]: freq: 185 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq2: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Peaking Apr 20 12:47:56 volumio volumio[626]: freq: 1300 Apr 20 12:47:56 volumio volumio[626]: q: 0.4 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq3: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Highshelf Apr 20 12:47:56 volumio volumio[626]: freq: 5500 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - eq1: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Lowshelf Apr 20 12:47:56 volumio volumio[626]: freq: 185 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq2: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Peaking Apr 20 12:47:56 volumio volumio[626]: freq: 1300 Apr 20 12:47:56 volumio volumio[626]: q: 0.4 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: eq3: Apr 20 12:47:56 volumio volumio[626]: type: Biquad Apr 20 12:47:56 volumio volumio[626]: parameters: Apr 20 12:47:56 volumio volumio[626]: type: Highshelf Apr 20 12:47:56 volumio volumio[626]: freq: 5500 Apr 20 12:47:56 volumio volumio[626]: q: 0.82 Apr 20 12:47:56 volumio volumio[626]: gain: 0 Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 12:47:56 volumio volumio[626]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 12:47:57 volumio systemd[1]: systemd-rfkill.service: Succeeded. Apr 20 12:48:00 volumio volumio[626]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Apr 20 12:48:00 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Apr 20 12:48:00 volumio sudo[1953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 20 12:48:00 volumio sudo[1953]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:00 volumio sudo[1953]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:00 volumio sudo[1955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 20 12:48:00 volumio sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:00 volumio sudo[1955]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:00 volumio volumio[626]: info: Permissions for /etc/network/interfaces set Apr 20 12:48:00 volumio volumio[626]: info: Restarting Wireless Network Apr 20 12:48:00 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:48:00 volumio volumio[626]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:48:00 volumio sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 20 12:48:00 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:00 volumio systemd[1]: Starting Wireless Services... Apr 20 12:48:00 volumio wireless.js[1960]: Cleaning previous... Apr 20 12:48:00 volumio sudo[1974]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:48:00 volumio sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:00 volumio sudo[1974]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:00 volumio sudo[1976]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:48:00 volumio sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:01 volumio sudo[1976]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:01 volumio wireless.js[1960]: Stopped aP Apr 20 12:48:01 volumio sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:01 volumio sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:01 volumio sudo[1983]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:01 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 20 12:48:01 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:01 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:01 volumio sudo[1994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:01 volumio sudo[1994]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:01 volumio sudo[1994]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:01 volumio sudo[1996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 20 12:48:01 volumio sudo[1996]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio sudo[1996]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:03 volumio wireless.js[1960]: SETTING APPROPRIATE REG DOMAIN: PL Apr 20 12:48:03 volumio sudo[2003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:03 volumio sudo[2003]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio sudo[2003]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:03 volumio sudo[2005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set PL Apr 20 12:48:03 volumio sudo[2005]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio sudo[2005]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:03 volumio wireless.js[1960]: SUCCESSFULLY SET NEW REGDOMAIN: PL Apr 20 12:48:03 volumio wireless.js[1960]: Start wireless flow Apr 20 12:48:03 volumio wireless.js[1960]: Stopped hotspot (if there).. Apr 20 12:48:03 volumio sudo[2010]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:48:03 volumio sudo[2010]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio sudo[2010]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:03 volumio sudo[2012]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:48:03 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio sudo[2012]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:03 volumio wireless.js[1960]: DHCP IP Apr 20 12:48:03 volumio wpa_supplicant[2014]: Successfully initialized wpa_supplicant Apr 20 12:48:03 volumio wireless.js[1960]: Start ap Apr 20 12:48:03 volumio sudo[2015]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 20 12:48:03 volumio sudo[2015]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:03 volumio dhcpcd[2016]: sending commands to master dhcpcd process Apr 20 12:48:03 volumio dhcpcd[511]: control command: /sbin/dhcpcd Apr 20 12:48:03 volumio sudo[2015]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:04 volumio wireless.js[1960]: trying... Apr 20 12:48:04 volumio sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:04 volumio sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:04 volumio sudo[2021]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:05 volumio wireless.js[1960]: trying... Apr 20 12:48:05 volumio sudo[2026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:05 volumio sudo[2026]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:05 volumio sudo[2026]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:05 volumio volumio[626]: info: Discovery: Started advertising with name: Volumio Apr 20 12:48:06 volumio wireless.js[1960]: trying... Apr 20 12:48:06 volumio sudo[2032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:06 volumio sudo[2032]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:06 volumio sudo[2032]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:07 volumio wireless.js[1960]: trying... Apr 20 12:48:07 volumio sudo[2037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:07 volumio sudo[2037]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:07 volumio sudo[2037]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:08 volumio wireless.js[1960]: trying... Apr 20 12:48:08 volumio sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:08 volumio sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:08 volumio sudo[2042]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:09 volumio wireless.js[1960]: trying... Apr 20 12:48:09 volumio sudo[2047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:09 volumio sudo[2047]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:09 volumio sudo[2047]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:10 volumio wireless.js[1960]: trying... Apr 20 12:48:10 volumio sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:10 volumio sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:10 volumio sudo[2052]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:11 volumio wireless.js[1960]: trying... Apr 20 12:48:11 volumio sudo[2057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:11 volumio sudo[2057]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:11 volumio sudo[2057]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:12 volumio wireless.js[1960]: trying... Apr 20 12:48:12 volumio sudo[2062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:12 volumio sudo[2062]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:12 volumio sudo[2062]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:13 volumio wireless.js[1960]: trying... Apr 20 12:48:13 volumio sudo[2067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:13 volumio sudo[2067]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:13 volumio sudo[2067]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:14 volumio wireless.js[1960]: trying... Apr 20 12:48:14 volumio sudo[2072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:14 volumio sudo[2072]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:14 volumio sudo[2072]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:15 volumio wireless.js[1960]: trying... Apr 20 12:48:15 volumio sudo[2077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:15 volumio sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:15 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:16 volumio wireless.js[1960]: trying... Apr 20 12:48:16 volumio sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:16 volumio sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:16 volumio sudo[2082]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:17 volumio wireless.js[1960]: trying... Apr 20 12:48:17 volumio sudo[2087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:17 volumio sudo[2087]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:17 volumio sudo[2087]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:18 volumio wireless.js[1960]: trying... Apr 20 12:48:18 volumio sudo[2092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:18 volumio sudo[2092]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:18 volumio sudo[2092]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:19 volumio wireless.js[1960]: trying... Apr 20 12:48:19 volumio sudo[2097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:19 volumio sudo[2097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:19 volumio sudo[2097]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:20 volumio wireless.js[1960]: trying... Apr 20 12:48:20 volumio sudo[2102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:20 volumio sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:20 volumio sudo[2102]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:21 volumio wireless.js[1960]: trying... Apr 20 12:48:21 volumio sudo[2107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:21 volumio sudo[2107]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:21 volumio sudo[2107]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:22 volumio wireless.js[1960]: trying... Apr 20 12:48:22 volumio sudo[2112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:22 volumio sudo[2112]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:22 volumio sudo[2112]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:22 volumio ntpd[602]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 20 12:48:23 volumio wireless.js[1960]: trying... Apr 20 12:48:23 volumio sudo[2117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:23 volumio sudo[2117]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:23 volumio sudo[2117]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:23 volumio ntpd[602]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 20 12:48:24 volumio wireless.js[1960]: Overtime, starting plan B Apr 20 12:48:24 volumio iwconfig[2123]: Error for wireless request "Set Power Management" (8B2C) : Apr 20 12:48:24 volumio iwconfig[2123]: SET failed on device wlan0 ; Operation not supported. Apr 20 12:48:24 volumio systemd[1]: Started Wireless Services. Apr 20 12:48:24 volumio sudo[1958]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:25 volumio ntpd[602]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 20 12:48:25 volumio ntpd[602]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 20 12:48:29 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:48:29 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:48:29 volumio sudo[2135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:48:29 volumio sudo[2135]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:29 volumio sudo[2135]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:34 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:48:34 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:48:34 volumio volumio[626]: info: Refreshing Cached IP Addresses Apr 20 12:48:34 volumio sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:48:34 volumio sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:34 volumio sudo[2151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:48:34 volumio systemd[1]: upmpdcli.service: Main process exited, code=killed, status=15/TERM Apr 20 12:48:34 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:48:34 volumio sudo[2151]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:34 volumio sudo[2149]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:34 volumio sudo[2153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:48:34 volumio sudo[2151]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:34 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:34 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:34 volumio volumio[626]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 4 Apr 20 12:48:34 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::volumioGetVisibleSources Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:48:35 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 20 12:48:35 volumio volumio[626]: info: Received Get System Info Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:48:35 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:48:35 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:48:35 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:48:35 volumio volumio[626]: info: Listing playlists Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 20 12:48:35 volumio sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 20 12:48:35 volumio sudo[2160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2160]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:48:35 volumio sudo[2165]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:48:35 volumio sudo[2165]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2173]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2173]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 20 12:48:35 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 20 12:48:35 volumio sudo[2179]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:48:35 volumio sudo[2179]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2185]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2185]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:48:35 volumio sudo[2188]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:35 volumio sudo[2190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 20 12:48:35 volumio sudo[2188]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:35 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:36 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:48:36 volumio volumio[626]: info: Received Get System Info Apr 20 12:48:36 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:48:36 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:48:36 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:48:36 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:48:36 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:48:36 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:48:37 volumio sudo[2190]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:44 volumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:48:44 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:44 volumio sudo[2198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:48:44 volumio sudo[2196]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:44 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:44 volumio sudo[2200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 20 12:48:44 volumio sudo[2200]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:44 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:44 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 20 12:48:44 volumio sudo[2200]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:44 volumio volumio[626]: info: Upmpdcli Daemon Started Apr 20 12:48:49 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Apr 20 12:48:49 volumio volumio[626]: info: Saving new wireless network Apr 20 12:48:49 volumio sudo[2228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Apr 20 12:48:49 volumio sudo[2228]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:49 volumio sudo[2228]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:49 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 20 12:48:49 volumio volumio[626]: info: Discovery: Restarting Advertising due to device name change Apr 20 12:48:49 volumio sudo[2231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 20 12:48:49 volumio sudo[2231]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:49 volumio systemd[1]: Stopping Wireless Services... Apr 20 12:48:49 volumio wpa_supplicant[2019]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 20 12:48:49 volumio wpa_supplicant[2019]: wlan0: CTRL-EVENT-TERMINATING Apr 20 12:48:49 volumio systemd[1]: wireless.service: Succeeded. Apr 20 12:48:49 volumio systemd[1]: Stopped Wireless Services. Apr 20 12:48:49 volumio systemd[1]: Starting Wireless Services... Apr 20 12:48:49 volumio wireless.js[2233]: Cleaning previous... Apr 20 12:48:49 volumio sudo[2249]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:48:49 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:49 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:49 volumio sudo[2251]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:48:49 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:49 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:49 volumio wireless.js[2233]: Stopped aP Apr 20 12:48:49 volumio sudo[2258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:49 volumio sudo[2258]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:50 volumio sudo[2258]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:50 volumio sudo[2260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 20 12:48:50 volumio sudo[2260]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:50 volumio sudo[2260]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:50 volumio sudo[2267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:50 volumio sudo[2267]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:50 volumio sudo[2267]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:50 volumio sudo[2269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 20 12:48:50 volumio sudo[2269]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:51 volumio sudo[2269]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:51 volumio wireless.js[2233]: SETTING APPROPRIATE REG DOMAIN: PL Apr 20 12:48:51 volumio sudo[2278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 20 12:48:51 volumio sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:51 volumio sudo[2278]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:51 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set PL Apr 20 12:48:51 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:51 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:51 volumio wireless.js[2233]: SUCCESSFULLY SET NEW REGDOMAIN: PL Apr 20 12:48:51 volumio wireless.js[2233]: Start wireless flow Apr 20 12:48:51 volumio wireless.js[2233]: Stopped hotspot (if there).. Apr 20 12:48:51 volumio sudo[2285]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 20 12:48:51 volumio sudo[2285]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:51 volumio sudo[2285]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:51 volumio sudo[2287]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 20 12:48:51 volumio sudo[2287]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:51 volumio sudo[2287]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:51 volumio wireless.js[2233]: DHCP IP Apr 20 12:48:51 volumio wpa_supplicant[2289]: Successfully initialized wpa_supplicant Apr 20 12:48:51 volumio wireless.js[2233]: Start ap Apr 20 12:48:52 volumio sudo[2290]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 20 12:48:52 volumio sudo[2290]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:52 volumio dhcpcd[2291]: sending commands to master dhcpcd process Apr 20 12:48:52 volumio dhcpcd[511]: control command: /sbin/dhcpcd Apr 20 12:48:52 volumio sudo[2290]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:52 volumio wireless.js[2233]: trying... Apr 20 12:48:52 volumio sudo[2296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:52 volumio sudo[2296]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:52 volumio sudo[2296]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:53 volumio wireless.js[2233]: trying... Apr 20 12:48:53 volumio sudo[2301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:53 volumio sudo[2301]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:53 volumio sudo[2301]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: SME: Trying to authenticate with b4:b0:24:f6:7d:c4 (SSID='tplink' freq=2457 MHz) Apr 20 12:48:54 volumio kernel: wlan0: authenticate with b4:b0:24:f6:7d:c4 Apr 20 12:48:54 volumio volumio[626]: info: Discovery: Started advertising with name: Volumio Apr 20 12:48:54 volumio kernel: wlan0: send auth to b4:b0:24:f6:7d:c4 (try 1/3) Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: Trying to associate with b4:b0:24:f6:7d:c4 (SSID='tplink' freq=2457 MHz) Apr 20 12:48:54 volumio kernel: wlan0: authenticated Apr 20 12:48:54 volumio kernel: wlan0: associate with b4:b0:24:f6:7d:c4 (try 1/3) Apr 20 12:48:54 volumio kernel: wlan0: RX AssocResp from b4:b0:24:f6:7d:c4 (capab=0x411 status=0 aid=1) Apr 20 12:48:54 volumio wpa_supplicant[2292]: RRM: Ignoring radio measurement request: Not associated Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: Associated with b4:b0:24:f6:7d:c4 Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 20 12:48:54 volumio kernel: wlan0: associated Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: WPA: Key negotiation completed with b4:b0:24:f6:7d:c4 [PTK=CCMP GTK=CCMP] Apr 20 12:48:54 volumio wpa_supplicant[2292]: wlan0: CTRL-EVENT-CONNECTED - Connection to b4:b0:24:f6:7d:c4 completed [id=0 id_str=] Apr 20 12:48:54 volumio dhcpcd[511]: wlan0: carrier acquired Apr 20 12:48:54 volumio dhcpcd[511]: wlan0: confile file changed, expiring leases Apr 20 12:48:54 volumio dhcpcd[511]: wlan0: IAID fc:93:c6:3f Apr 20 12:48:54 volumio dhcpcd[511]: wlan0: soliciting an IPv6 router Apr 20 12:48:54 volumio dhcpcd[511]: wlan0: soliciting a DHCP lease Apr 20 12:48:54 volumio wireless.js[2233]: trying... Apr 20 12:48:54 volumio sudo[2323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:54 volumio sudo[2323]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:54 volumio sudo[2323]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:55 volumio wireless.js[2233]: trying... Apr 20 12:48:55 volumio sudo[2328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:55 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:55 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:56 volumio wireless.js[2233]: trying... Apr 20 12:48:56 volumio sudo[2333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:56 volumio sudo[2333]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:56 volumio sudo[2333]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:57 volumio wireless.js[2233]: trying... Apr 20 12:48:57 volumio sudo[2338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:57 volumio sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:57 volumio sudo[2338]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:58 volumio dhcpcd[511]: wlan0: offered 192.168.5.4 from 192.168.5.1 Apr 20 12:48:58 volumio wireless.js[2233]: trying... Apr 20 12:48:58 volumio sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:58 volumio sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:58 volumio sudo[2343]: pam_unix(sudo:session): session closed for user root Apr 20 12:48:58 volumio dhcpcd[511]: wlan0: probing address 192.168.5.4/24 Apr 20 12:48:59 volumio wireless.js[2233]: trying... Apr 20 12:48:59 volumio sudo[2348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:48:59 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:48:59 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:00 volumio wireless.js[2233]: trying... Apr 20 12:49:00 volumio sudo[2353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:49:00 volumio sudo[2353]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:00 volumio sudo[2353]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:01 volumio wireless.js[2233]: trying... Apr 20 12:49:01 volumio sudo[2358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:49:01 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:01 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:02 volumio wireless.js[2233]: trying... Apr 20 12:49:02 volumio sudo[2363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:49:02 volumio sudo[2363]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:02 volumio sudo[2363]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:03 volumio dhcpcd[511]: wlan0: leased 192.168.5.4 for infinity Apr 20 12:49:03 volumio dhcpcd[511]: wlan0: adding route to 192.168.5.0/24 Apr 20 12:49:03 volumio dhcpcd[511]: wlan0: adding default route via 192.168.5.1 Apr 20 12:49:03 volumio avahi-daemon[501]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.5.4. Apr 20 12:49:03 volumio avahi-daemon[501]: New relevant interface wlan0.IPv4 for mDNS. Apr 20 12:49:03 volumio avahi-daemon[501]: Registering new address record for 192.168.5.4 on wlan0.IPv4. Apr 20 12:49:03 volumio wireless.js[2233]: trying... Apr 20 12:49:03 volumio sudo[2379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 20 12:49:03 volumio sudo[2379]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:03 volumio sudo[2379]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:03 volumio wireless.js[2233]: Connected to: ----tplink Apr 20 12:49:03 volumio wireless.js[2233]: ---- Apr 20 12:49:03 volumio sudo[2390]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:49:03 volumio sudo[2390]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:03 volumio sudo[2390]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:03 volumio wireless.js[2233]: ... joined AP, wlan0 IPv4 is 192.168.5.4, ipV6 is undefined Apr 20 12:49:03 volumio wireless.js[2233]: It's done! AP Apr 20 12:49:04 volumio iwconfig[2405]: Error for wireless request "Set Power Management" (8B2C) : Apr 20 12:49:04 volumio iwconfig[2405]: SET failed on device wlan0 ; Operation not supported. Apr 20 12:49:04 volumio systemd[1]: Started Wireless Services. Apr 20 12:49:04 volumio sudo[2231]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:04 volumio ntpd[602]: ntpd exiting on signal 15 (Terminated) Apr 20 12:49:04 volumio systemd[1]: Stopping Network Time Service... Apr 20 12:49:04 volumio systemd[1]: ntp.service: Succeeded. Apr 20 12:49:04 volumio systemd[1]: Stopped Network Time Service. Apr 20 12:49:04 volumio systemd[1]: Starting Network Time Service... Apr 20 12:49:04 volumio ntpd[2408]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 20 12:49:04 volumio ntpd[2408]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 20 12:49:04 volumio systemd[1]: Started Network Time Service. Apr 20 12:49:04 volumio ntpd[2414]: proto: precision = 0.085 usec (-23) Apr 20 12:49:04 volumio ntpd[2414]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 20 12:49:04 volumio ntpd[2414]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 20 12:49:04 volumio ntpd[2414]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 480 days ago Apr 20 12:49:04 volumio ntpd[2414]: Listen and drop on 0 v6wildcard [::]:123 Apr 20 12:49:04 volumio ntpd[2414]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 20 12:49:04 volumio ntpd[2414]: Listen normally on 2 lo 127.0.0.1:123 Apr 20 12:49:04 volumio ntpd[2414]: Listen normally on 3 wlan0 192.168.5.4:123 Apr 20 12:49:04 volumio ntpd[2414]: Listening on routing socket on fd #20 for interface updates Apr 20 12:49:04 volumio ntpd[2414]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 20 12:49:04 volumio ntpd[2414]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 20 12:49:04 volumio volumio[626]: info: Discovery: adding 72f8cd45-8345-4da9-91e8-3476b4b86c2b Apr 20 12:49:04 volumio volumio[626]: info: Discovery: Found device Volumio Apr 20 12:49:04 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:49:04 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin bluetooth to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin multiroom to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin metavolumio to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin cd_controller to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 20 12:49:05 volumio volumio[626]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 20 12:49:05 volumio ntpd[2414]: Soliciting pool server 54.37.233.160 Apr 20 12:49:06 volumio ntpd[2414]: Soliciting pool server 162.159.200.1 Apr 20 12:49:06 volumio ntpd[2414]: Soliciting pool server 178.215.228.24 Apr 20 12:49:06 volumio volumio[626]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 20 12:49:06 volumio volumio[626]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 20 12:49:06 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:49:06 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:49:06 volumio volumio[626]: info: Starting MyVolumio Remote Streaming Endpoints Apr 20 12:49:06 volumio volumio[626]: info: MyVolumio login type: Token Apr 20 12:49:06 volumio volumio[626]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 20 12:49:06 volumio volumio[626]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 20 12:49:06 volumio volumio[2203]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 20 12:49:06 volumio volumio[2203]: .........++++ Apr 20 12:49:07 volumio ntpd[2414]: Soliciting pool server 162.159.200.123 Apr 20 12:49:07 volumio ntpd[2414]: Soliciting pool server 213.222.217.11 Apr 20 12:49:07 volumio ntpd[2414]: Soliciting pool server 91.212.242.20 Apr 20 12:49:07 volumio volumio[626]: info: Starting Streaming Service Transparent Proxy Apr 20 12:49:07 volumio volumio[626]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 20 12:49:07 volumio volumio[626]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 20 12:49:07 volumio volumio[626]: info: Streaming services startup Apr 20 12:49:07 volumio volumio[626]: info: Starting Streaming Daemon Apr 20 12:49:07 volumio sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 20 12:49:07 volumio sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:07 volumio volumio[626]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 20 12:49:07 volumio sudo[2432]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:07 volumio volumio[626]: error: Cannot start Volumio Streaming Daemon Apr 20 12:49:07 volumio volumio[626]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 20 12:49:07 volumio volumio[626]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 20 12:49:07 volumio volumio[626]: error: MyVolumio Custom Token format not valid, refreshing it Apr 20 12:49:08 volumio ntpd[2414]: Soliciting pool server 213.222.217.10 Apr 20 12:49:08 volumio ntpd[2414]: Soliciting pool server 91.102.113.48 Apr 20 12:49:08 volumio ntpd[2414]: Soliciting pool server 192.86.14.67 Apr 20 12:49:08 volumio ntpd[2414]: Soliciting pool server 188.241.28.254 Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:49:08 volumio volumio[626]: info: Received Get System Info Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:49:08 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:49:08 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:49:08 volumio volumio[626]: STREAMING PROXY: Starting server on port 3245 Apr 20 12:49:08 volumio volumio[626]: Node JS runtime: 14 Apr 20 12:49:08 volumio volumio[626]: info: MyVolumio login type: Token Apr 20 12:49:08 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 20 12:49:08 volumio volumio[626]: info: MyVolumio login type: Token Apr 20 12:49:09 volumio volumio[626]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 20 12:49:09 volumio volumio[626]: info: MYVOLUMIO: Adding device Apr 20 12:49:09 volumio volumio[626]: info: MYVOLUMIO: Evaluating Server Apr 20 12:49:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 20 12:49:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 20 12:49:09 volumio ntpd[2414]: Soliciting pool server 89.25.168.148 Apr 20 12:49:09 volumio ntpd[2414]: Soliciting pool server 185.157.13.96 Apr 20 12:49:09 volumio ntpd[2414]: Soliciting pool server 46.174.178.150 Apr 20 12:49:09 volumio sudo[2443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:49:09 volumio sudo[2443]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:09 volumio sudo[2443]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:09 volumio sudo[2446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 20 12:49:09 volumio sudo[2446]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:09 volumio sudo[2446]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:09 volumio volumio[626]: info: MyVolumio status changed Apr 20 12:49:09 volumio volumio[626]: info: Streaming services startup Apr 20 12:49:09 volumio volumio[626]: info: Starting Streaming Daemon Apr 20 12:49:09 volumio volumio[626]: info: Removing browser output: myVolumio user plan is not superstar Apr 20 12:49:09 volumio volumio[626]: info: Removing audio output: Apr 20 12:49:09 volumio volumio[626]: info: Stoppping Tunnel 1 Apr 20 12:49:09 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 20 12:49:09 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:09 volumio sudo[2468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 20 12:49:09 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:09 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:09 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:09 volumio volumio[626]: info: Remote SSH Stopped Apr 20 12:49:09 volumio volumio[626]: error: Cannot start Volumio Streaming Daemon Apr 20 12:49:09 volumio volumio[626]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 20 12:49:09 volumio volumio[626]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 20 12:49:09 volumio volumio[626]: info: Setting Geolocation for MyVolumio to eu5 Apr 20 12:49:09 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:49:10 volumio ntpd[2414]: Soliciting pool server 46.175.224.7 Apr 20 12:49:10 volumio ntpd[2414]: Soliciting pool server 150.254.65.62 Apr 20 12:49:10 volumio volumio[626]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 20 12:49:10 volumio volumio[626]: info: Updating MyVolumio device info Apr 20 12:49:10 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 12:49:11 volumio ntpd[2414]: Soliciting pool server 193.25.222.136 Apr 20 12:49:11 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 20 12:49:11 volumio volumio[626]: info: Received Get System Info Apr 20 12:49:11 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 12:49:11 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 12:49:11 volumio volumio[626]: info: Discovery: Getting this device information Apr 20 12:49:11 volumio volumio[626]: info: CoreCommandRouter::volumioGetState Apr 20 12:49:11 volumio volumio[626]: info: CorePlayQueue::getTrack 0 Apr 20 12:49:11 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 12:49:11 volumio volumio[626]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 20 12:49:11 volumio volumio[2203]: ...........................................................................................................................................................................................................................................................................................................................................................................................................++++ Apr 20 12:49:11 volumio volumio[2203]: e is 65537 (0x010001) Apr 20 12:49:11 volumio volumio[2203]: writing RSA key Apr 20 12:49:14 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 20 12:49:14 volumio volumio[626]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 20 12:49:14 volumio volumio[626]: info: Refreshing Cached IP Addresses Apr 20 12:49:14 volumio sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 20 12:49:14 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:14 volumio sudo[2501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 20 12:49:14 volumio systemd[1]: upmpdcli.service: Succeeded. Apr 20 12:49:14 volumio sudo[2499]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:14 volumio sudo[2501]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:14 volumio sudo[2503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 20 12:49:14 volumio sudo[2503]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 12:49:14 volumio sudo[2501]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:14 volumio sudo[2503]: pam_unix(sudo:session): session closed for user root Apr 20 12:49:14 volumio volumio[626]: info: MYVOLUMIO: Adding device Apr 20 12:49:14 volumio volumio[626]: info: MYVOLUMIO: Evaluating Server Apr 20 12:48:02 volumio volumio[626]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Apr 20 12:48:02 volumio volumio[626]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:48:02 volumio volumio[626]: Error: Unable to resolve or reject the same promise twice Apr 20 12:48:02 volumio volumio[626]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 20 12:48:02 volumio volumio[626]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:31902) Apr 20 12:48:02 volumio volumio[626]: at Socket.emit (events.js:412:35) Apr 20 12:48:02 volumio volumio[626]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 20 12:48:02 volumio volumio[626]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 20 12:48:02 volumio volumio[626]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16ac161f does not match aorg 0000000000.00000000 from server@46.175.224.7 xmt 0xe9ce1be2.d8107480 Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16b04822 does not match aorg 0000000000.00000000 from server@192.86.14.67 xmt 0xe9ce1be2.d80ea5df Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16b0eaf0 does not match aorg 0000000000.00000000 from server@213.222.217.11 xmt 0xe9ce1be2.d891d726 Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16afb1d4 does not match aorg 0000000000.00000000 from server@188.241.28.254 xmt 0xe9ce1be2.d872dcb0 Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16aef398 does not match aorg 0000000000.00000000 from server@89.25.168.148 xmt 0xe9ce1be2.da081d72 Apr 20 12:48:02 volumio ntpd[2414]: receive: Unexpected origin timestamp 0xe9ce1c2b.16b18529 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xe9ce1be2.d9b029ec Apr 20 12:48:03 volumio sudo[2531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 12:47 Apr 20 12:48:03 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 12:06:09 PM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="0d1482005c1581ed7b0ddba1caf77bf6"