-- Logs begin at Thu 2024-04-25 02:39:24 EDT, end at Thu 2024-04-25 17:08:43 EDT. -- Apr 25 17:07:02 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:03 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:03 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:03 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:03 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:04 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:04 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:05 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:05 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:05 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:06 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:06 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:08 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:08 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:12 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:13 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:13 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:13 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:13 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:14 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:14 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:15 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:15 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:15 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:15 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:15 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:18 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:18 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:22 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:23 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:23 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:23 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:23 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:24 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:24 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:25 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:25 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:25 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:26 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:26 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:28 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:28 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:32 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:33 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:33 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:33 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:33 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:34 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:34 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:35 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:35 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:35 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:35 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:36 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:38 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:38 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:42 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:43 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:43 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:43 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:43 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:44 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:44 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:44 val volumio[10405]: info: Tunnel connection is inactive, restarting it Apr 25 17:07:44 val volumio[10405]: info: Starting Tunnel 1 Apr 25 17:07:44 val volumio[10405]: info: Starting Tunnel Connection Checker Apr 25 17:07:44 val sudo[30353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 25 17:07:44 val sudo[30353]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 25 17:07:45 val autossh[29098]: received signal to exit (15) Apr 25 17:07:45 val systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 25 17:07:45 val systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Apr 25 17:07:45 val systemd[1]: sshtunnel.service: Succeeded. Apr 25 17:07:45 val systemd[1]: Stopped MyVolumio SSH Tunnel. Apr 25 17:07:45 val volumio[10405]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 25 17:07:45 val volumio[10405]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 25 17:07:45 val systemd[1]: Started MyVolumio SSH Tunnel. Apr 25 17:07:45 val sudo[30353]: pam_unix(sudo:session): session closed for user root Apr 25 17:07:45 val volumio[10405]: info: Remote SSH Started Apr 25 17:07:45 val autossh[30357]: port set to 0, monitoring disabled Apr 25 17:07:45 val autossh[30357]: starting ssh (count 1) Apr 25 17:07:45 val autossh[30357]: ssh child pid is 30360 Apr 25 17:07:45 val volumio[10405]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Apr 25 17:07:45 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:07:45 val volumiossh-tunnel[30355]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts. Apr 25 17:07:45 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:45 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:45 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:45 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:45 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:45 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:46 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:46 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:48 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:48 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:48 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:48 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:48 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:52 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:07:53 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:53 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:53 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:53 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:07:53 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:55 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:07:55 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:07:55 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:07:55 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:07:55 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:07:55 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:07:55 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:07:55 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:07:58 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:07:58 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:07:58 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:07:58 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:07:58 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:02 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:08:02 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:02 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:03 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:03 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:03 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:03 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:05 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:08:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:08:05 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:08:05 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:08:05 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:05 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:06 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:08:08 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:08:08 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:08:08 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:12 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:08:12 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:12 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:13 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:13 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:13 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:13 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:15 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:08:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:08:15 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:08:15 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:08:15 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:15 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:15 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:08:18 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:08:18 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:08:18 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 17:08:22 val volumio[10405]: info: Discovery: Getting this device information Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 17:08:22 val volumio[10405]: verbose: New Socket.io Connection to 192.168.0.65 from 192.168.0.69 UA: unknown Total Clients: 5 Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 25 17:08:22 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 25 17:08:22 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:08:22 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:22 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:23 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:23 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:23 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:23 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:24 val sudo[30676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 25 17:08:24 val sudo[30676]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 25 17:08:24 val sudo[30676]: pam_unix(sudo:session): session closed for user root Apr 25 17:08:24 val sudo[30686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 25 17:08:24 val sudo[30686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 25 17:08:24 val sudo[30686]: pam_unix(sudo:session): session closed for user root Apr 25 17:08:24 val volumio[10405]: verbose: New Socket.io Connection to 192.168.0.65 from 192.168.0.69 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 6 Apr 25 17:08:24 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 25 17:08:24 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 25 17:08:24 val volumio[10405]: info: CoreCommandRouter::volumioGetVisibleSources Apr 25 17:08:24 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 25 17:08:24 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 25 17:08:25 val volumio[10405]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 25 17:08:25 val volumio[10405]: info: Received Get System Info Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 17:08:25 val volumio[10405]: info: Discovery: Getting this device information Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:25 val volumio[10405]: info: Listing playlists Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 25 17:08:25 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:08:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:08:25 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:08:25 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:08:25 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:25 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:25 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:25 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:26 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 25 17:08:26 val volumio[10405]: info: Received Get System Info Apr 25 17:08:26 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 17:08:26 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 17:08:26 val volumio[10405]: info: Discovery: Getting this device information Apr 25 17:08:26 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:26 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 17:08:27 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:27 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:27 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 25 17:08:27 val volumio[10405]: info: Received Get System Info Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 25 17:08:27 val volumio[10405]: info: Discovery: Getting this device information Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:27 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 25 17:08:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:08:28 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:08:28 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:08:28 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:28 val volumio[10405]: info: CoreCommandRouter::volumioGetQueue Apr 25 17:08:28 val volumio[10405]: info: CoreStateMachine::getQueue Apr 25 17:08:28 val volumio[10405]: info: CorePlayQueue::getQueue Apr 25 17:08:31 val volumio[10405]: info: CoreCommandRouter::volumioGetState Apr 25 17:08:32 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:08:32 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:32 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:33 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:33 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:33 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:33 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:33 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:33 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:33 val volumio[10405]: info: Executing endpoint metavolumio Apr 25 17:08:33 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 25 17:08:33 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:33 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:34 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 25 17:08:34 val volumio[10405]: info: Preload queue cleared Apr 25 17:08:35 val wpa_supplicant[770]: wlan0: Associated with 78:8c:b5:12:0d:b8 Apr 25 17:08:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:8c:b5:12:0d:b8 completed [id=0 id_str=] Apr 25 17:08:35 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 25 17:08:35 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 25 17:08:35 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:35 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:35 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-DISCONNECTED bssid=78:8c:b5:12:0d:b8 reason=2 Apr 25 17:08:38 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 25 17:08:38 val wpa_supplicant[770]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Apr 25 17:08:38 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:39 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 25 17:08:39 val volumio[10405]: info: Preload queue cleared Apr 25 17:08:41 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 25 17:08:41 val volumio[10405]: info: Preload queue cleared Apr 25 17:08:42 val wpa_supplicant[770]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=78:8c:b5:12:0d:b8 status_code=16 Apr 25 17:08:42 val volumio[10405]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 25 17:08:42 val dhcpcd[851]: wlan0: carrier acquired Apr 25 17:08:42 val dhcpcd[851]: wlan0: IAID eb:3d:2c:1f Apr 25 17:08:43 val dhcpcd[851]: wlan0: soliciting a DHCP lease Apr 25 17:08:43 val volumio[10405]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 17:08:43 val volumio[10405]: TypeError: Cannot read property 'length' of undefined Apr 25 17:08:43 val volumio[10405]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 25 17:08:43 val volumio[10405]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 25 17:08:43 val volumio[10405]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 25 17:08:43 val volumio[10405]: at Parser.emit (events.js:315:20) Apr 25 17:08:43 val volumio[10405]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 25 17:08:43 val volumio[10405]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 25 17:08:43 val volumio[10405]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 25 17:08:43 val volumio[10405]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 25 17:08:43 val volumio[10405]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 25 17:08:43 val volumio[10405]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 25 17:08:43 val volumio[10405]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 25 17:08:43 val volumio[10405]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 25 17:08:43 val volumio[10405]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 25 17:08:43 val volumio[10405]: at IncomingMessage.emit (events.js:327:22) Apr 25 17:08:43 val volumio[10405]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 25 17:08:43 val volumio[10405]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 25 17:08:43 val volumio[10405]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 17:08:43 val dhcpcd[851]: wlan0: soliciting an IPv6 router Apr 25 17:08:43 val wpa_supplicant[770]: wlan0: Trying to associate with SSID 'Incredible99' Apr 25 17:08:43 val dhcpcd[851]: wlan0: carrier lost Apr 25 17:08:43 val sudo[30804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-25 17:07 Apr 25 17:08:43 val sudo[30804]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"