-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-01-19 21:12:53 CET. -- Jan 19 21:11:00 volumio wireless.js[3112]: trying... Jan 19 21:11:00 volumio sudo[3309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:00 volumio sudo[3309]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:00 volumio sudo[3309]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:00 volumio dhcpcd[3214]: wlan0: offered 192.168.1.250 from 192.168.1.254 Jan 19 21:11:00 volumio dhcpcd[3214]: wlan0: probing address 192.168.1.250/24 Jan 19 21:11:01 volumio wireless.js[3112]: trying... Jan 19 21:11:01 volumio sudo[3315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:01 volumio sudo[3315]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:01 volumio sudo[3315]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:02 volumio wireless.js[3112]: trying... Jan 19 21:11:02 volumio sudo[3318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:02 volumio sudo[3318]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:02 volumio sudo[3318]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:03 volumio wireless.js[3112]: trying... Jan 19 21:11:03 volumio sudo[3321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:03 volumio sudo[3321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:03 volumio sudo[3321]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:04 volumio wireless.js[3112]: trying... Jan 19 21:11:04 volumio sudo[3324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:04 volumio sudo[3324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:04 volumio sudo[3324]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:05 volumio wireless.js[3112]: trying... Jan 19 21:11:05 volumio sudo[3327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 19 21:11:05 volumio sudo[3327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:05 volumio sudo[3327]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:05 volumio dhcpcd[3214]: wlan0: leased 192.168.1.250 for 86400 seconds Jan 19 21:11:05 volumio avahi-daemon[588]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.250. Jan 19 21:11:05 volumio avahi-daemon[588]: New relevant interface wlan0.IPv4 for mDNS. Jan 19 21:11:05 volumio dhcpcd[3214]: wlan0: adding route to 192.168.1.0/24 Jan 19 21:11:05 volumio dhcpcd[3214]: wlan0: adding default route via 192.168.1.254 Jan 19 21:11:05 volumio avahi-daemon[588]: Registering new address record for 192.168.1.250 on wlan0.IPv4. Jan 19 21:11:06 volumio wireless.js[3112]: Overtime, starting plan B Jan 19 21:11:06 volumio systemd[1]: Started Wireless Services. Jan 19 21:11:06 volumio sudo[3107]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:06 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 19 21:11:06 volumio volumio[869]: info: Discovery: adding 62ac5032-86ca-4027-a7b7-be08171e1727 Jan 19 21:11:06 volumio volumio[869]: info: Discovery: Found device Volumio Jan 19 21:11:06 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:06 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:06 volumio ntpd[762]: Listen normally on 6 wlan0 192.168.1.250:123 Jan 19 21:11:06 volumio ntpd[762]: new interface(s) found: waking up resolver Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:07 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:07 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:07 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:07 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:07 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250:3000 from 192.168.1.245 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:07 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 19 21:11:07 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 19 21:11:08 volumio volumio[869]: info: Volumio Network Manager: Network status updated: 2 Jan 19 21:11:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jan 19 21:11:11 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jan 19 21:11:11 volumio sudo[3373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:11 volumio sudo[3373]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:11 volumio sudo[3373]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:11 volumio sudo[3376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 19 21:11:11 volumio sudo[3376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:11 volumio sudo[3376]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:11 volumio volumio[869]: info: MRS: Found cast device: Google-Home-Mini-0906c0eb80eb664166d27585c1da7c8b Jan 19 21:11:13 volumio volumio[869]: info: Tunnel connection is inactive, restarting it Jan 19 21:11:13 volumio volumio[869]: info: Starting Tunnel 1 Jan 19 21:11:13 volumio volumio[869]: info: Starting Tunnel Connection Checker Jan 19 21:11:13 volumio sudo[3389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 19 21:11:13 volumio sudo[3389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:13 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Jan 19 21:11:13 volumio autossh[2542]: received signal to exit (15) Jan 19 21:11:13 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jan 19 21:11:13 volumio systemd[1]: sshtunnel.service: Succeeded. Jan 19 21:11:13 volumio volumio[869]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 19 21:11:13 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Jan 19 21:11:13 volumio volumio[869]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 19 21:11:14 volumio systemd[1]: Started MyVolumio SSH Tunnel. Jan 19 21:11:14 volumio sudo[3389]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:14 volumio volumio[869]: info: Remote SSH Started Jan 19 21:11:14 volumio autossh[3426]: port set to 0, monitoring disabled Jan 19 21:11:14 volumio autossh[3426]: starting ssh (count 1) Jan 19 21:11:14 volumio autossh[3426]: ssh child pid is 3432 Jan 19 21:11:14 volumio volumio[869]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 19 21:11:14 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:14 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:14 volumio volumiossh-tunnel[3406]: Warning: Permanently added '[eu7.myvolumio.org]:2222,[167.71.43.69]:2222' (RSA) to the list of known hosts. Jan 19 21:11:16 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jan 19 21:11:16 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jan 19 21:11:16 volumio volumio[869]: info: Refreshing Cached IP Addresses Jan 19 21:11:16 volumio sudo[3435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jan 19 21:11:16 volumio sudo[3435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:16 volumio sudo[3435]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:16 volumio sudo[3438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:16 volumio sudo[3438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:16 volumio sudo[3438]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:16 volumio volumio[869]: error: Upnp client error: Error: This socket has been ended by the other party Jan 19 21:11:16 volumio sudo[3441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:16 volumio sudo[3441]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:16 volumio sudo[3441]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:18 volumio sudo[3444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3444]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:18 volumio sudo[3446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3446]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:18 volumio sudo[3450]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3450]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:18 volumio sudo[3453]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3453]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 19 21:11:18 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 19 21:11:18 volumio sudo[3456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:18 volumio sudo[3456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3456]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:18 volumio sudo[3458]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3458]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 19 21:11:18 volumio sudo[3476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:18 volumio sudo[3476]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3476]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio sudo[3478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:18 volumio sudo[3478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:18 volumio sudo[3478]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::volumioGetVisibleSources Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:18 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 19 21:11:18 volumio volumio[869]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 19 21:11:18 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:18 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:18 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:18 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:18 volumio volumio[869]: info: Listing playlists Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:11:18 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 19 21:11:18 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::volumioGetVisibleSources Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:19 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 19 21:11:19 volumio volumio[869]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 19 21:11:19 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:19 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:19 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:19 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:19 volumio volumio[869]: info: Listing playlists Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:11:19 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:20 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:20 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:21 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:21 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:21 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:21 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:21 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:21 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:21 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:24 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:24 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:24 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:24 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:24 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:24 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:24 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:24 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:24 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:11:24 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:24 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:24 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:24 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:26 volumio sudo[3485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:11:26 volumio sudo[3485]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:26 volumio sudo[3485]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:26 volumio sudo[3488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:11:26 volumio sudo[3488]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:26 volumio sudo[3488]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:26 volumio sudo[3491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 19 21:11:26 volumio sudo[3491]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:11:26 volumio sudo[3491]: pam_unix(sudo:session): session closed for user root Jan 19 21:11:26 volumio volumio[869]: info: Upmpdcli Daemon Started Jan 19 21:11:28 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 19 21:11:29 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 19 21:11:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:32 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:32 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:32 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:34 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jan 19 21:11:35 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jan 19 21:11:36 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:11:36 volumio volumio[869]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 19 21:11:36 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 19 21:11:37 volumio volumio[869]: info: Received Get System Version Jan 19 21:11:37 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 19 21:11:37 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:37 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:37 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:37 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:37 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:37 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:37 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:11:38 volumio volumio[869]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 19 21:11:38 volumio volumio[869]: info: Received Get System Version Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 19 21:11:38 volumio volumio[869]: info: Received Get System Info Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:11:38 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:11:38 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:11:38 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:02 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:02 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:02 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:02 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:02 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:02 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:20 volumio sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:12:20 volumio sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:12:20 volumio sudo[3637]: pam_unix(sudo:session): session closed for user root Jan 19 21:12:20 volumio sudo[3640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:12:20 volumio sudo[3640]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:12:20 volumio sudo[3640]: pam_unix(sudo:session): session closed for user root Jan 19 21:12:20 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 19 21:12:20 volumio sudo[3643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 19 21:12:20 volumio sudo[3643]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:12:20 volumio sudo[3643]: pam_unix(sudo:session): session closed for user root Jan 19 21:12:20 volumio sudo[3646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 19 21:12:20 volumio sudo[3646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 19 21:12:20 volumio sudo[3646]: pam_unix(sudo:session): session closed for user root Jan 19 21:12:20 volumio volumio[869]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.245 UA: Mozilla/5.0 (Linux; Android 14; SM-S921B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.260 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetVisibleSources Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 19 21:12:20 volumio volumio[869]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 19 21:12:20 volumio volumio[869]: info: Received Get System Info Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:20 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:20 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:20 volumio volumio[869]: info: Listing playlists Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:12:20 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:12:22 volumio volumio[869]: info: Received Get System Info Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:22 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:22 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:22 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:12:23 volumio volumio[869]: info: Received Get System Info Jan 19 21:12:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:23 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:23 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:23 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:23 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:25 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 19 21:12:25 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 19 21:12:30 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 19 21:12:31 volumio volumio[869]: info: CoreCommandRouter::Close All Modals sent Jan 19 21:12:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Jan 19 21:12:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:32 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:32 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:32 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:32 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:37 volumio dhcpcd[3214]: wlan0: carrier lost Jan 19 21:12:37 volumio wpa_supplicant[3193]: wlan0: Associated with a4:16:e7:1a:22:a0 Jan 19 21:12:37 volumio wpa_supplicant[3193]: wlan0: CTRL-EVENT-CONNECTED - Connection to a4:16:e7:1a:22:a0 completed [id=0 id_str=] Jan 19 21:12:37 volumio wpa_supplicant[3193]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 19 21:12:37 volumio avahi-daemon[588]: Withdrawing address record for 192.168.1.250 on wlan0. Jan 19 21:12:37 volumio avahi-daemon[588]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.250. Jan 19 21:12:37 volumio dhcpcd[3214]: wlan0: deleting route to 192.168.1.0/24 Jan 19 21:12:37 volumio dhcpcd[3214]: wlan0: deleting default route via 192.168.1.254 Jan 19 21:12:37 volumio avahi-daemon[588]: Interface wlan0.IPv4 no longer relevant for mDNS. Jan 19 21:12:37 volumio volumio[869]: info: Discovery: A device disappeared from network Jan 19 21:12:37 volumio volumio[869]: info: Discovery: Device volumio disappeared from network Jan 19 21:12:37 volumio dnsmasq[858]: reading /etc/resolv.conf Jan 19 21:12:37 volumio dnsmasq[858]: using nameserver 208.67.222.222#53 Jan 19 21:12:37 volumio dnsmasq[858]: using nameserver 208.67.220.220#53 Jan 19 21:12:37 volumio dhcpcd[3214]: wlan0: carrier acquired Jan 19 21:12:37 volumio dhcpcd[3214]: wlan0: IAID eb:15:82:ac Jan 19 21:12:38 volumio dhcpcd[3214]: wlan0: rebinding lease of 192.168.1.250 Jan 19 21:12:38 volumio dhcpcd[3214]: wlan0: probing address 192.168.1.250/24 Jan 19 21:12:38 volumio dhcpcd[3214]: wlan0: soliciting an IPv6 router Jan 19 21:12:38 volumio ntpd[762]: Deleting interface #6 wlan0, 192.168.1.250#123, interface stats: received=55, sent=55, dropped=1, active_time=92 secs Jan 19 21:12:38 volumio ntpd[762]: 185.157.229.254 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 185.19.184.35 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 89.46.74.148 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 212.6.50.243 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 162.159.200.123 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 31.14.133.122 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 162.159.200.1 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 212.45.144.88 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 151.22.209.90 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 95.110.254.234 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 93.94.88.51 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 93.94.88.50 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio ntpd[762]: 85.199.214.99 local addr 192.168.1.250 -> Jan 19 21:12:38 volumio volumio[869]: info: Volumio Network Manager: Network status updated: 0 Jan 19 21:12:43 volumio dhcpcd[3214]: wlan0: leased 192.168.1.250 for 86400 seconds Jan 19 21:12:43 volumio avahi-daemon[588]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.250. Jan 19 21:12:43 volumio avahi-daemon[588]: New relevant interface wlan0.IPv4 for mDNS. Jan 19 21:12:43 volumio dhcpcd[3214]: wlan0: adding route to 192.168.1.0/24 Jan 19 21:12:43 volumio dhcpcd[3214]: wlan0: adding default route via 192.168.1.254 Jan 19 21:12:43 volumio avahi-daemon[588]: Registering new address record for 192.168.1.250 on wlan0.IPv4. Jan 19 21:12:43 volumio dnsmasq[858]: reading /etc/resolv.conf Jan 19 21:12:43 volumio dnsmasq[858]: using nameserver 192.168.1.254#53 Jan 19 21:12:43 volumio dnsmasq[858]: using nameserver 208.67.222.222#53 Jan 19 21:12:43 volumio dnsmasq[858]: using nameserver 208.67.220.220#53 Jan 19 21:12:44 volumio volumio[869]: info: MRS: Found cast device: Google-Home-Mini-0906c0eb80eb664166d27585c1da7c8b Jan 19 21:12:44 volumio ntpd[762]: Listen normally on 7 wlan0 192.168.1.250:123 Jan 19 21:12:44 volumio ntpd[762]: new interface(s) found: waking up resolver Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 19 21:12:46 volumio volumio[869]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 19 21:12:46 volumio volumio[869]: info: Received Get System Version Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 19 21:12:46 volumio volumio[869]: info: Received Get System Info Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 19 21:12:46 volumio volumio[869]: info: Discovery: Getting this device information Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:46 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:46 volumio volumio[869]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:48 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:48 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:48 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:48 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Volumio Network Manager: Network status updated: 2 Jan 19 21:12:49 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:49 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Check plugin dependencies Jan 19 21:12:49 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 19 21:12:49 volumio volumio[869]: info: Checking if plugin already exists Jan 19 21:12:49 volumio volumio[869]: info: Rename folder Jan 19 21:12:49 volumio volumio[869]: info: Check plugin dependencies Jan 19 21:12:49 volumio volumio[869]: error: Error finding native modules: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name "*.node" 2>/dev/null {"status":1,"signal":null,"output":[null,"",""],"pid":3786,"stdout":"","stderr":"","stack":"Error: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name \"*.node\" 2>/dev/null\n at checkExecSyncError (child_process.js:616:11)\n at execSync (child_process.js:652:15)\n at PluginManager.checkPluginDependencies (/volumio/app/pluginmanager.js:1149:26)\n at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)\n at processTicksAndRejections (internal/process/task_queues.js:75:11)"} Jan 19 21:12:49 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:49 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:49 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:49 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:49 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/UIConfig.json Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/config.json Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/gitignore Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/index.js Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/install.sh Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/package-lock.json Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/package.json Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/requiredConf.json Jan 19 21:12:49 volumio volumio[869]: info: Removing /data/plugins//audiophonicsonoff/uninstall.sh Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:49 volumio volumio[869]: info: Error: Error Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Move to category Jan 19 21:12:49 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:49 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:49 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:49 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:49 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:49 volumio volumio[869]: info: Error: Error Jan 19 21:12:49 volumio volumio[869]: info: Folder /data/temp removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /data/temp removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Check plugin dependencies Jan 19 21:12:49 volumio volumio[869]: error: Error finding native modules: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name "*.node" 2>/dev/null {"status":1,"signal":null,"output":[null,"",""],"pid":3788,"stdout":"","stderr":"","stack":"Error: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name \"*.node\" 2>/dev/null\n at checkExecSyncError (child_process.js:616:11)\n at execSync (child_process.js:652:15)\n at PluginManager.checkPluginDependencies (/volumio/app/pluginmanager.js:1149:26)\n at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)\n at processTicksAndRejections (internal/process/task_queues.js:75:11)"} Jan 19 21:12:49 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:49 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:49 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:49 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:49 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:49 volumio volumio[869]: info: Error: Error Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /data/temp removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Discovery: adding 62ac5032-86ca-4027-a7b7-be08171e1727 Jan 19 21:12:49 volumio volumio[869]: info: Discovery: Found device Volumio Jan 19 21:12:49 volumio volumio[869]: info: CoreCommandRouter::volumioGetState Jan 19 21:12:49 volumio volumio[869]: info: CorePlayQueue::getTrack 0 Jan 19 21:12:49 volumio volumio[869]: info: Check plugin dependencies Jan 19 21:12:49 volumio volumio[869]: error: Error finding native modules: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name "*.node" 2>/dev/null {"status":1,"signal":null,"output":[null,"",""],"pid":3790,"stdout":"","stderr":"","stack":"Error: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name \"*.node\" 2>/dev/null\n at checkExecSyncError (child_process.js:616:11)\n at execSync (child_process.js:652:15)\n at PluginManager.checkPluginDependencies (/volumio/app/pluginmanager.js:1149:26)\n at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)\n at processTicksAndRejections (internal/process/task_queues.js:75:11)"} Jan 19 21:12:49 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:49 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:49 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:49 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:49 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:49 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:49 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:49 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:49 volumio volumio[869]: info: Error: Error Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /data/temp removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:49 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:52 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:52 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:52 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:52 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:52 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:52 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:52 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:52 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:52 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:52 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:52 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:52 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:52 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:52 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:52 volumio volumio[869]: info: Error: Error Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:52 volumio volumio[869]: info: An error occurred installing the plugin. Rolling back config Jan 19 21:12:52 volumio volumio[869]: info: Plugin folders cleanup Jan 19 21:12:52 volumio volumio[869]: info: Scanning into folder /volumio/app/plugins/ Jan 19 21:12:52 volumio volumio[869]: info: Scanning category audio_interface Jan 19 21:12:52 volumio volumio[869]: info: Scanning category miscellanea Jan 19 21:12:52 volumio volumio[869]: info: Scanning category music_service Jan 19 21:12:52 volumio volumio[869]: info: Scanning category plugins.json Jan 19 21:12:52 volumio volumio[869]: info: Scanning category system_controller Jan 19 21:12:52 volumio volumio[869]: info: Scanning category user_interface Jan 19 21:12:52 volumio volumio[869]: info: Scanning into folder /data/plugins/ Jan 19 21:12:52 volumio volumio[869]: info: Scanning category audiophonicsonoff Jan 19 21:12:52 volumio volumio[869]: info: Plugin folders cleanup completed Jan 19 21:12:52 volumio volumio[869]: info: Error: Error Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/downloaded_plugin.zip removed Jan 19 21:12:52 volumio volumio[869]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Jan 19 21:12:52 volumio volumio[869]: info: Folder /tmp/plugins removed Jan 19 21:12:52 volumio volumio[869]: info: Folder /data/temp removed Jan 19 21:12:52 volumio volumio[869]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 21:12:52 volumio volumio[869]: Error: Unable to resolve or reject the same promise twice Jan 19 21:12:52 volumio volumio[869]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 19 21:12:52 volumio volumio[869]: at /volumio/app/pluginmanager.js:1087:11 Jan 19 21:12:52 volumio volumio[869]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Jan 19 21:12:52 volumio volumio[869]: at FSReqCallback.oncomplete (fs.js:171:23) Jan 19 21:12:52 volumio volumio[869]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 21:12:53 volumio sudo[3810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 21:11 Jan 19 21:12:53 volumio sudo[3810]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"