-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-06-14 01:36:09 CEST. -- Jun 14 01:35:00 volumio-rpib3 ntpd[876]: Listen and drop on 0 v6wildcard [::]:123 Jun 14 01:35:00 volumio-rpib3 ntpd[876]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 14 01:35:00 volumio-rpib3 ntpd[876]: Listen normally on 2 lo 127.0.0.1:123 Jun 14 01:35:00 volumio-rpib3 ntpd[876]: Listening on routing socket on fd #19 for interface updates Jun 14 01:35:00 volumio-rpib3 ntpd[876]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 14 01:35:00 volumio-rpib3 ntpd[876]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 14 01:35:00 volumio-rpib3 ifplugd(eth0)[886]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 14 01:35:00 volumio-rpib3 ifplugd(eth0)[886]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Jun 14 01:35:00 volumio-rpib3 sudo[849]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 14 01:35:00 volumio-rpib3 sudo[849]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:00 volumio-rpib3 sudo[849]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jun 14 01:35:00 volumio-rpib3 sudo[849]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:00 volumio-rpib3 kernel: hwmon hwmon1: Voltage normalised Jun 14 01:35:00 volumio-rpib3 ntpd[876]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 14 01:35:00 volumio-rpib3 nmbd[861]: [2025/06/14 01:35:00.945631, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 14 01:35:00 volumio-rpib3 nmbd[861]: started asyncdns process 897 Jun 14 01:35:00 volumio-rpib3 nmbd[861]: [2025/06/14 01:35:00.948085, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 14 01:35:00 volumio-rpib3 nmbd[861]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 14 01:35:00 volumio-rpib3 nmbd[861]: [2025/06/14 01:35:00.948269, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 14 01:35:00 volumio-rpib3 nmbd[861]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 14 01:35:01 volumio-rpib3 wireless.js[607]: Cleaning previous... Jun 14 01:35:01 volumio-rpib3 sudo[905]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 14 01:35:01 volumio-rpib3 sudo[905]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:01 volumio-rpib3 sudo[905]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:01 volumio-rpib3 sudo[907]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 14 01:35:01 volumio-rpib3 sudo[907]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:01 volumio-rpib3 sudo[907]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:01 volumio-rpib3 wireless.js[607]: Stopped aP Jun 14 01:35:01 volumio-rpib3 sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 14 01:35:01 volumio-rpib3 sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:01 volumio-rpib3 systemd[1]: systemd-rfkill.service: Succeeded. Jun 14 01:35:01 volumio-rpib3 ntpd[876]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 14 01:35:02 volumio-rpib3 sudo[914]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:02 volumio-rpib3 sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 14 01:35:02 volumio-rpib3 sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:02 volumio-rpib3 sudo[916]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:02 volumio-rpib3 sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 14 01:35:02 volumio-rpib3 sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:02 volumio-rpib3 sudo[923]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:02 volumio-rpib3 sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 14 01:35:02 volumio-rpib3 sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:02 volumio-rpib3 ntpd[876]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 14 01:35:03 volumio-rpib3 mpd[896]: Jun 14 01:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 14 01:35:03 volumio-rpib3 systemd[1]: Started Music Player Daemon. Jun 14 01:35:03 volumio-rpib3 mpd_monitor.sh[602]: MPD Monitor Service: MPD restarted due to no mpc output. Jun 14 01:35:03 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:03] [info] asio async_connect error: system:111 (Connection refused) Jun 14 01:35:03 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 14 01:35:03 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:03] [error] handle_connect error: Underlying Transport Error Jun 14 01:35:03 volumio-rpib3 ntpd[876]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 14 01:35:03 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: Fetching time from Volumio... Jun 14 01:35:03 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: Date not found in response Jun 14 01:35:03 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: Retrying in 5 seconds... Jun 14 01:35:04 volumio-rpib3 bthelper[740]: Changing power off succeeded Jun 14 01:35:04 volumio-rpib3 bthelper[740]: [CHG] Controller B8:27:EB:96:14:55 Powered: no Jun 14 01:35:04 volumio-rpib3 bthelper[740]: [CHG] Controller B8:27:EB:96:14:55 Discovering: no Jun 14 01:35:04 volumio-rpib3 bthelper[740]: [CHG] Controller B8:27:EB:96:14:55 Class: 0x00000000 Jun 14 01:35:04 volumio-rpib3 bthelper[740]: [CHG] Controller B8:27:EB:96:14:55 Class: 0x0000041c Jun 14 01:35:04 volumio-rpib3 bthelper[740]: Changing power on succeeded Jun 14 01:35:05 volumio-rpib3 sh[586]: eth0: leased 192.168.3.43 for 604800 seconds Jun 14 01:35:05 volumio-rpib3 sh[586]: eth0: adding route to 192.168.3.0/24 Jun 14 01:35:05 volumio-rpib3 sh[586]: eth0: adding default route via 192.168.3.1 Jun 14 01:35:05 volumio-rpib3 sh[586]: eth0: dhcp_envoption 213: Operation not supported Jun 14 01:35:05 volumio-rpib3 dhcpcd[694]: eth0: leased 192.168.3.43 for 604800 seconds Jun 14 01:35:05 volumio-rpib3 dhcpcd[694]: eth0: adding route to 192.168.3.0/24 Jun 14 01:35:05 volumio-rpib3 dhcpcd[694]: eth0: adding default route via 192.168.3.1 Jun 14 01:35:05 volumio-rpib3 dhcpcd[694]: eth0: dhcp_envoption 213: Operation not supported Jun 14 01:35:05 volumio-rpib3 avahi-daemon[623]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.43. Jun 14 01:35:05 volumio-rpib3 avahi-daemon[623]: New relevant interface eth0.IPv4 for mDNS. Jun 14 01:35:05 volumio-rpib3 avahi-daemon[623]: Registering new address record for 192.168.3.43 on eth0.IPv4. Jun 14 01:35:05 volumio-rpib3 sh[586]: forked to background, child pid 964 Jun 14 01:35:05 volumio-rpib3 dhcpcd[694]: forked to background, child pid 964 Jun 14 01:35:05 volumio-rpib3 ifplugd(eth0)[886]: client: ifup: interface eth0 already configured Jun 14 01:35:05 volumio-rpib3 sh[586]: eth0=eth0 Jun 14 01:35:05 volumio-rpib3 ifplugd(eth0)[886]: Program executed successfully. Jun 14 01:35:05 volumio-rpib3 ifplugd[857]: Network Interface Plugging Daemon...start eth0...done. Jun 14 01:35:05 volumio-rpib3 systemd[1]: Started LSB: Brings up/down network automatically. Jun 14 01:35:05 volumio-rpib3 nmbd[861]: [2025/06/14 01:35:05.954034, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 14 01:35:05 volumio-rpib3 nmbd[861]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 14 01:35:05 volumio-rpib3 systemd[1]: Started Samba NMB Daemon. Jun 14 01:35:06 volumio-rpib3 systemd[1]: Starting Samba Winbind Daemon... Jun 14 01:35:06 volumio-rpib3 winbindd[990]: [2025/06/14 01:35:06.328666, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 14 01:35:06 volumio-rpib3 winbindd[990]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 14 01:35:06 volumio-rpib3 winbindd[990]: [2025/06/14 01:35:06.345561, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 14 01:35:06 volumio-rpib3 systemd[1]: Started Samba Winbind Daemon. Jun 14 01:35:06 volumio-rpib3 winbindd[990]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 14 01:35:06 volumio-rpib3 systemd[1]: Starting Samba SMB Daemon... Jun 14 01:35:06 volumio-rpib3 smbd[995]: [2025/06/14 01:35:06.880796, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 14 01:35:06 volumio-rpib3 smbd[995]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 14 01:35:06 volumio-rpib3 systemd[1]: Started Samba SMB Daemon. Jun 14 01:35:06 volumio-rpib3 ntpd[876]: Listen normally on 3 eth0 192.168.3.43:123 Jun 14 01:35:06 volumio-rpib3 ntpd[876]: new interface(s) found: waking up resolver Jun 14 01:35:07 volumio-rpib3 sudo[925]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: SETTING APPROPRIATE REG DOMAIN: FR Jun 14 01:35:07 volumio-rpib3 sudo[1004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 14 01:35:07 volumio-rpib3 sudo[1004]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:07 volumio-rpib3 sudo[1004]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:07 volumio-rpib3 sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set FR Jun 14 01:35:07 volumio-rpib3 sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:07 volumio-rpib3 sudo[1006]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: SUCCESSFULLY SET NEW REGDOMAIN: FR Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: Start wireless flow Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: Stopped hotspot (if there).. Jun 14 01:35:07 volumio-rpib3 sudo[1011]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 14 01:35:07 volumio-rpib3 sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:07 volumio-rpib3 sudo[1011]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:07 volumio-rpib3 sudo[1013]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 14 01:35:07 volumio-rpib3 sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:07 volumio-rpib3 sudo[1013]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: DHCP IP Jun 14 01:35:07 volumio-rpib3 wireless.js[607]: Start ap Jun 14 01:35:07 volumio-rpib3 wpa_supplicant[1015]: Successfully initialized wpa_supplicant Jun 14 01:35:07 volumio-rpib3 sudo[1016]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 14 01:35:07 volumio-rpib3 sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:07 volumio-rpib3 dhcpcd[1017]: dev: loaded udev Jun 14 01:35:08 volumio-rpib3 dhcpcd-run-hooks[1026]: wlan1: starting wpa_supplicant Jun 14 01:35:08 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:08 volumio-rpib3 sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:08 volumio-rpib3 sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:08 volumio-rpib3 sudo[1029]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:08 volumio-rpib3 dhcpcd[1017]: wlan1: connected to Access Point `' Jun 14 01:35:08 volumio-rpib3 kernel: hwmon hwmon1: Undervoltage detected! Jun 14 01:35:08 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: Fetching time from Volumio... Jun 14 01:35:09 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: Setting system time to: 2025-06-14 01:35:30 Jun 14 01:35:09 volumio-rpib3 sudo[1064]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-14 01:35:30 Jun 14 01:35:09 volumio-rpib3 sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:09 volumio-rpib3 dbus-daemon[603]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.10' (uid=0 pid=1065 comm="timedatectl set-time 2025-06-14 01:35:30 ") Jun 14 01:35:09 volumio-rpib3 systemd[1]: Starting Time & Date Service... Jun 14 01:35:09 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:09 volumio-rpib3 sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:09 volumio-rpib3 sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:09 volumio-rpib3 sudo[1068]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan0: connected to Access Point `' Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: DUID 00:01:00:01:2e:c1:0d:8b:b8:27:eb:3c:be:ff Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: eth0: IAID eb:3c:be:ff Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: eth0: adding address fe80::ba27:ebff:fe3c:beff Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: ipv6_addaddr1: Permission denied Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan1: waiting for carrier Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan0: waiting for carrier Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan1: carrier acquired Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan1: connected to Access Point `HUAWEI-104YL0' Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan1: IAID eb:69:eb:aa Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: wlan1: adding address fe80::ba27:ebff:fe69:ebaa Jun 14 01:35:09 volumio-rpib3 dhcpcd[1017]: ipv6_addaddr1: Permission denied Jun 14 01:35:09 volumio-rpib3 dbus-daemon[603]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 14 01:35:09 volumio-rpib3 systemd[1]: Started Time & Date Service. Jun 14 01:35:30 volumio-rpib3 systemd-timedated[1066]: Changed local time to Sat Jun 14 01:35:30 2025 Jun 14 01:35:30 volumio-rpib3 sudo[1064]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:30 volumio-rpib3 volumio-time-update[617]: volumio-time-update-util: System time updated successfully. Jun 14 01:35:30 volumio-rpib3 systemd[1]: Started Volumio Time Update Utility. Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: soliciting an IPv6 router Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: wlan1: soliciting an IPv6 router Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: rebinding lease of 192.168.3.43 Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: leased 192.168.3.43 for 604800 seconds Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: adding route to 192.168.3.0/24 Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: adding default route via 192.168.3.1 Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: dhcp_envoption 213: Operation not supported Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: eth0: dhcp_envoption 213: Operation not supported Jun 14 01:35:30 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:30 volumio-rpib3 sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:30 volumio-rpib3 sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:30 volumio-rpib3 sudo[1102]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:30 volumio-rpib3 dhcpcd[1017]: forked to background, child pid 1112 Jun 14 01:35:30 volumio-rpib3 sudo[1016]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:30 volumio-rpib3 dhcpcd[1112]: wlan1: soliciting a DHCP lease Jun 14 01:35:30 volumio-rpib3 dhcpcd[1112]: wlan1: offered 192.168.3.32 from 192.168.3.1 Jun 14 01:35:30 volumio-rpib3 dhcpcd[1112]: wlan1: probing address 192.168.3.32/24 Jun 14 01:35:31 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:31] [info] asio async_connect error: system:111 (Connection refused) Jun 14 01:35:31 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:31] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 14 01:35:31 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:31] [error] handle_connect error: Underlying Transport Error Jun 14 01:35:31 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:31 volumio-rpib3 sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:31 volumio-rpib3 sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:31 volumio-rpib3 sudo[1114]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:32 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:32 volumio-rpib3 sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:32 volumio-rpib3 sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:32 volumio-rpib3 sudo[1117]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:33 volumio-rpib3 kernel: hwmon hwmon1: Voltage normalised Jun 14 01:35:33 volumio-rpib3 wpa_supplicant[1031]: wlan0: SME: Trying to authenticate with a4:c7:4b:c6:62:04 (SSID='HUAWEI-104YL0' freq=2467 MHz) Jun 14 01:35:33 volumio-rpib3 kernel: wlan0: authenticate with a4:c7:4b:c6:62:04 Jun 14 01:35:33 volumio-rpib3 kernel: wlan0: 80 MHz not supported, disabling VHT Jun 14 01:35:33 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:33 volumio-rpib3 sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:33 volumio-rpib3 sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:33 volumio-rpib3 sudo[1121]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:34 volumio-rpib3 wpa_supplicant[1031]: wlan0: Trying to associate with a4:c7:4b:c6:62:04 (SSID='HUAWEI-104YL0' freq=2467 MHz) Jun 14 01:35:34 volumio-rpib3 kernel: wlan0: send auth to a4:c7:4b:c6:62:04 (try 1/3) Jun 14 01:35:34 volumio-rpib3 kernel: wlan0: authenticated Jun 14 01:35:34 volumio-rpib3 kernel: wlan0: associate with a4:c7:4b:c6:62:04 (try 1/3) Jun 14 01:35:34 volumio-rpib3 wpa_supplicant[1031]: wlan0: Associated with a4:c7:4b:c6:62:04 Jun 14 01:35:34 volumio-rpib3 kernel: wlan0: RX AssocResp from a4:c7:4b:c6:62:04 (capab=0x1431 status=0 aid=2) Jun 14 01:35:34 volumio-rpib3 kernel: wlan0: associated Jun 14 01:35:34 volumio-rpib3 wpa_supplicant[1031]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 14 01:35:34 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:34 volumio-rpib3 sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:34 volumio-rpib3 sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:34 volumio-rpib3 kernel: cryptd: max_cpu_qlen set to 1000 Jun 14 01:35:34 volumio-rpib3 sudo[1131]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:34 volumio-rpib3 wpa_supplicant[1031]: wlan0: WPA: Key negotiation completed with a4:c7:4b:c6:62:04 [PTK=CCMP GTK=TKIP] Jun 14 01:35:34 volumio-rpib3 wpa_supplicant[1031]: wlan0: CTRL-EVENT-CONNECTED - Connection to a4:c7:4b:c6:62:04 completed [id=0 id_str=] Jun 14 01:35:34 volumio-rpib3 dhcpcd[1112]: wlan0: carrier acquired Jun 14 01:35:34 volumio-rpib3 dhcpcd[1112]: wlan0: connected to Access Point `HUAWEI-104YL0' Jun 14 01:35:34 volumio-rpib3 dhcpcd[1112]: wlan0: IAID 00:62:81:d3 Jun 14 01:35:34 volumio-rpib3 dhcpcd[1112]: wlan0: adding address fe80::20f:ff:fe62:81d3 Jun 14 01:35:34 volumio-rpib3 dhcpcd[1112]: ipv6_addaddr1: Permission denied Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: soliciting an IPv6 router Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: rebinding lease of 192.168.3.32 Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: NAK: Invalid Request Message from 192.168.3.1 Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: message: Invalid Request Message Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: soliciting a DHCP lease Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: offered 192.168.3.36 from 192.168.3.1 Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan0: probing address 192.168.3.36/24 Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan1: leased 192.168.3.32 for 604800 seconds Jun 14 01:35:35 volumio-rpib3 avahi-daemon[623]: Joining mDNS multicast group on interface wlan1.IPv4 with address 192.168.3.32. Jun 14 01:35:35 volumio-rpib3 avahi-daemon[623]: New relevant interface wlan1.IPv4 for mDNS. Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan1: adding route to 192.168.3.0/24 Jun 14 01:35:35 volumio-rpib3 avahi-daemon[623]: Registering new address record for 192.168.3.32 on wlan1.IPv4. Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan1: adding default route via 192.168.3.1 Jun 14 01:35:35 volumio-rpib3 dhcpcd[1112]: wlan1: dhcp_envoption 213: Operation not supported Jun 14 01:35:35 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:35 volumio-rpib3 sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:35 volumio-rpib3 sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:35 volumio-rpib3 sudo[1179]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:35 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:35 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:35 volumio-rpib3 sudo[1182]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:35 volumio-rpib3 sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:35 volumio-rpib3 sudo[1182]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:35 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:36 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:36 volumio-rpib3 sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:36 volumio-rpib3 sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:36 volumio-rpib3 sudo[1185]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:36 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:36 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:36 volumio-rpib3 sudo[1188]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:36 volumio-rpib3 sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:36 volumio-rpib3 sudo[1188]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:36 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:37 volumio-rpib3 ntpd[876]: Listen normally on 4 wlan1 192.168.3.32:123 Jun 14 01:35:37 volumio-rpib3 ntpd[876]: new interface(s) found: waking up resolver Jun 14 01:35:37 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:37 volumio-rpib3 sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:37 volumio-rpib3 sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:37 volumio-rpib3 sudo[1192]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:37 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:37 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:37 volumio-rpib3 sudo[1195]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:37 volumio-rpib3 sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:37 volumio-rpib3 sudo[1195]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:37 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:38 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:38 volumio-rpib3 sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:38 volumio-rpib3 sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:38 volumio-rpib3 sudo[1198]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:38 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:38 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:38 volumio-rpib3 sudo[1201]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:38 volumio-rpib3 sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:38 volumio-rpib3 sudo[1201]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:38 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:39 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:39 volumio-rpib3 sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:39 volumio-rpib3 sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:39 volumio-rpib3 sudo[1204]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:39 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:39 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:39 volumio-rpib3 sudo[1207]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:39 volumio-rpib3 sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:39 volumio-rpib3 sudo[1207]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:39 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:40 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:40 volumio-rpib3 sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:40 volumio-rpib3 sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:40 volumio-rpib3 sudo[1210]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:40 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:40 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:40 volumio-rpib3 sudo[1213]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:40 volumio-rpib3 sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:40 volumio-rpib3 sudo[1213]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:40 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is undefined, ipV6 is undefined Jun 14 01:35:40 volumio-rpib3 dhcpcd[1112]: wlan0: leased 192.168.3.36 for 604800 seconds Jun 14 01:35:40 volumio-rpib3 dhcpcd[1112]: wlan0: adding route to 192.168.3.0/24 Jun 14 01:35:40 volumio-rpib3 avahi-daemon[623]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.36. Jun 14 01:35:40 volumio-rpib3 dhcpcd[1112]: wlan0: adding default route via 192.168.3.1 Jun 14 01:35:40 volumio-rpib3 avahi-daemon[623]: New relevant interface wlan0.IPv4 for mDNS. Jun 14 01:35:40 volumio-rpib3 avahi-daemon[623]: Registering new address record for 192.168.3.36 on wlan0.IPv4. Jun 14 01:35:40 volumio-rpib3 dhcpcd[1112]: wlan0: dhcp_envoption 213: Operation not supported Jun 14 01:35:41 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:41] [info] asio async_connect error: system:111 (Connection refused) Jun 14 01:35:41 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:41] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 14 01:35:41 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:41] [error] handle_connect error: Underlying Transport Error Jun 14 01:35:41 volumio-rpib3 wireless.js[607]: trying... Jun 14 01:35:41 volumio-rpib3 sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 14 01:35:41 volumio-rpib3 sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:41 volumio-rpib3 sudo[1239]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:41 volumio-rpib3 wireless.js[607]: Connected to: ----HUAWEI-104YL0 Jun 14 01:35:41 volumio-rpib3 wireless.js[607]: ---- Jun 14 01:35:41 volumio-rpib3 sudo[1242]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:41 volumio-rpib3 sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:41 volumio-rpib3 sudo[1242]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:41 volumio-rpib3 wireless.js[607]: ... joined AP, wlan0 IPv4 is 192.168.3.36, ipV6 is undefined Jun 14 01:35:41 volumio-rpib3 wireless.js[607]: It's done! AP Jun 14 01:35:41 volumio-rpib3 systemd[1]: Started Wireless Services. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Started Volumio Backend Module. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Started Volumio Cpu Tweaker. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Reached target Multi-User System. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Reached target Graphical Interface. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 14 01:35:41 volumio-rpib3 volumio-cpu-tweak[1248]: Setting RT Priority for mpd Jun 14 01:35:41 volumio-rpib3 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 14 01:35:41 volumio-rpib3 systemd[1]: Startup finished in 14.050s (kernel) + 30.140s (userspace) = 44.190s. Jun 14 01:35:41 volumio-rpib3 volumio-cpu-tweak[1248]: Setting MPD Affinity Jun 14 01:35:41 volumio-rpib3 volumio-cpu-tweak[1248]: pid 896's current affinity mask: f Jun 14 01:35:41 volumio-rpib3 volumio-cpu-tweak[1248]: pid 896's new affinity mask: 3 Jun 14 01:35:42 volumio-rpib3 volumio-cpu-tweak[1248]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jun 14 01:35:42 volumio-rpib3 volumio-cpu-tweak[1248]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 14 01:35:42 volumio-rpib3 systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 14 01:35:42 volumio-rpib3 ntpd[876]: Listen normally on 5 wlan0 192.168.3.36:123 Jun 14 01:35:42 volumio-rpib3 ntpd[876]: new interface(s) found: waking up resolver Jun 14 01:35:44 volumio-rpib3 volumio[1247]: info: ------------------------------------------- Jun 14 01:35:44 volumio-rpib3 volumio[1247]: info: ----- Volumio3 ---- Jun 14 01:35:44 volumio-rpib3 volumio[1247]: info: ------------------------------------------- Jun 14 01:35:44 volumio-rpib3 volumio[1247]: info: ----- System startup ---- Jun 14 01:35:44 volumio-rpib3 volumio[1247]: info: ------------------------------------------- Jun 14 01:35:45 volumio-rpib3 systemd[1]: systemd-fsckd.service: Succeeded. Jun 14 01:35:45 volumio-rpib3 volumio[1247]: info: MYVOLUMIO Environment detected Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Plugin folders cleanup Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning into folder /volumio/app/plugins/ Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category audio_interface Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category miscellanea Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category music_service Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category plugins.json Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category system_controller Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category user_interface Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning into folder /data/plugins/ Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category audio_interface Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category music_service Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category system_controller Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category system_hardware Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Scanning category user_interface Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Plugin folders cleanup completed Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: ------------------------------------------- Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: ----- Core plugins startup ---- Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: ------------------------------------------- Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Loading plugins from folder /volumio/app/plugins/ Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Adding plugin upnp to MyMusic Plugins Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Loading plugins from folder /data/plugins/ Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Loading plugin "system"... Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Loading plugin "ampswitch"... Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin ampswitch Jun 14 01:35:46 volumio-rpib3 volumio[1247]: info: Loading plugin "appearance"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "network"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Refreshing Cached IP Addresses Jun 14 01:35:48 volumio-rpib3 sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 01:35:48 volumio-rpib3 sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:35:48 volumio-rpib3 sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1283]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:48 volumio-rpib3 sudo[1285]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "services"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "alsa_controller"... Jun 14 01:35:48 volumio-rpib3 sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 14 01:35:48 volumio-rpib3 sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "wizard"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "networkfs"... Jun 14 01:35:48 volumio-rpib3 sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.3.8:C:\\Users\\JB\\Music /mnt/NAS/Desktop-MSI-W11 Jun 14 01:35:48 volumio-rpib3 sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.3.8:Desktop-MSI-W11 /mnt/NAS/MSI Jun 14 01:35:48 volumio-rpib3 sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //192.168.3.21/Music /mnt/NAS/Music_BPI-256 Jun 14 01:35:48 volumio-rpib3 sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.3.84:Desktop-Asrock /mnt/NAS/ASROCK Jun 14 01:35:48 volumio-rpib3 sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Starting Udev Watcher for removable devices Jun 14 01:35:48 volumio-rpib3 sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.3.84:C:\\users\\JB\\Music /mnt/NAS/Desktop-ASROCK Jun 14 01:35:48 volumio-rpib3 sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.84/Desktop-Asrock /mnt/NAS/MSI Jun 14 01:35:48 volumio-rpib3 sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Ignoring mount for partition: boot Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Ignoring mount for partition: volumio Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Ignoring mount for partition: volumio_data Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "volumio_command_line_client"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "upnp"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: [1749857748647] Starting Upmpd Daemon Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "my_music"... Jun 14 01:35:48 volumio-rpib3 volumio[1247]: info: Loading plugin "mpd"... Jun 14 01:35:48 volumio-rpib3 kernel: Key type cifs.spnego registered Jun 14 01:35:48 volumio-rpib3 kernel: Key type cifs.idmap registered Jun 14 01:35:48 volumio-rpib3 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jun 14 01:35:48 volumio-rpib3 kernel: CIFS: Attempting to mount //192.168.3.84/Desktop-Asrock Jun 14 01:35:49 volumio-rpib3 sudo[1333]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:49 volumio-rpib3 kernel: CIFS: Status code returned 0xc0000022 STATUS_ACCESS_DENIED Jun 14 01:35:49 volumio-rpib3 kernel: CIFS: VFS: \\192.168.3.84 Send error in SessSetup = -13 Jun 14 01:35:49 volumio-rpib3 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Jun 14 01:35:49 volumio-rpib3 kernel: CIFS: Attempting to mount //192.168.3.21/Music Jun 14 01:35:49 volumio-rpib3 sudo[1316]: pam_unix(sudo:session): session closed for user root Jun 14 01:35:49 volumio-rpib3 volumio[1247]: info: Loading plugin "upnp_browser"... Jun 14 01:35:49 volumio-rpib3 kernel: hwmon hwmon1: Undervoltage detected! Jun 14 01:35:50 volumio-rpib3 systemd[1]: systemd-hostnamed.service: Succeeded. Jun 14 01:35:50 volumio-rpib3 volumio[1247]: info: Loading plugin "alarm-clock"... Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "airplay_emulation"... Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Starting Shairport Sync Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "last_100"... Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "webradio"... Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "i2s_dacs"... Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "volumiodiscovery"... Jun 14 01:35:51 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:35:51] [connect] Successful connection Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** For more information see Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 14 01:35:51 volumio-rpib3 volumio[1247]: *** WARNING *** For more information see Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** For more information see Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 14 01:35:51 volumio-rpib3 node[1247]: *** WARNING *** For more information see Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Discovery: Started advertising with name: Volumio-rpib3 Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 14 01:35:51 volumio-rpib3 volumio[1247]: info: Loading plugin "jellyfin"... Jun 14 01:35:53 volumio-rpib3 volumio[1247]: info: Loading plugin "soundcloud"... Jun 14 01:35:53 volumio-rpib3 volumio[1247]: info: Plugin spop is not enabled Jun 14 01:35:53 volumio-rpib3 volumio[1247]: info: Loading plugin "squeezelite_mc"... Jun 14 01:35:54 volumio-rpib3 kernel: hwmon hwmon1: Voltage normalised Jun 14 01:35:54 volumio-rpib3 volumio[1247]: info: Loading plugin "youtube2"... Jun 14 01:35:56 volumio-rpib3 kernel: hwmon hwmon1: Undervoltage detected! Jun 14 01:36:00 volumio-rpib3 systemd[1]: systemd-timedated.service: Succeeded. Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Plugin ytcr is not enabled Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Plugin ytmusic is not enabled Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Plugin autostart is not enabled Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "outputs"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "albumart"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Plugin example_plugin is not enabled Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "inputs"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "updater_comm"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Plugin mpdemulation is not enabled Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "rest_api"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "websocket"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Starting Socket.io Server version 2.3.0 Jun 14 01:36:00 volumio-rpib3 volumio[1247]: info: Loading plugin "fusiondsp"... Jun 14 01:36:00 volumio-rpib3 volumio[1247]: Forking 3 albumart workers Jun 14 01:36:01 volumio-rpib3 sudo[1294]: pam_unix(sudo:session): session closed for user root Jun 14 01:36:01 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin fusiondsp Jun 14 01:36:01 volumio-rpib3 volumio[1247]: info: Loading plugin "lms"... Jun 14 01:36:02 volumio-rpib3 volumio[1247]: info: Loading plugin "minidlna"... Jun 14 01:36:02 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin minidlna Jun 14 01:36:02 volumio-rpib3 volumio[1247]: Starting albumart workers Jun 14 01:36:02 volumio-rpib3 volumio[1247]: info: Loading plugin "backup_restore"... Jun 14 01:36:02 volumio-rpib3 volumio[1247]: Starting albumart workers Jun 14 01:36:02 volumio-rpib3 volumio[1247]: Starting albumart workers Jun 14 01:36:03 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin backup_restore Jun 14 01:36:03 volumio-rpib3 volumio[1247]: info: Loading plugin "ir_controller"... Jun 14 01:36:03 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin ir_controller Jun 14 01:36:03 volumio-rpib3 volumio[1247]: info: Loading plugin "remotepi"... Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin remotepi Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: Loading plugin "touch_display"... Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: Applying required configuration parameters for plugin touch_display Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: Loading i18n strings for locale fr Jun 14 01:36:04 volumio-rpib3 volumio[1247]: Updating browse sources language Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::initPlayerControls Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 14 01:36:04 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 01:36:05 volumio-rpib3 volumio[1247]: Express server listening on port 3000 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: [Metrics] WebUI: 21s 372.09ms Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::resetVolumioState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::getcurrentVolume Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioRetrievevolume Jun 14 01:36:05 volumio-rpib3 sudo[1452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 01:36:05 volumio-rpib3 sudo[1452]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:36:05 volumio-rpib3 sudo[1452]: pam_unix(sudo:session): session closed for user root Jun 14 01:36:05 volumio-rpib3 sudo[1454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 01:36:05 volumio-rpib3 sudo[1454]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:36:05 volumio-rpib3 sudo[1454]: pam_unix(sudo:session): session closed for user root Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Volumio Network Manager: Network status updated: 3 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Cannot mount NAS MSI at system boot, trial number 1 ,retrying in 5 seconds Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.32:3000 from 192.168.3.14 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: Getting this device information Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: VolumeController:: Volume=81 Mute =false Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::pushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioPushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::updateTrackBlock Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrackBlock Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioRetrievevolume Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Reloading queue from file Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Setting Device type: Raspberry PI Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::setRepeat false single undefined Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::pushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioPushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::setRandom false Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::pushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioPushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 14 01:36:05 volumio-rpib3 sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 14 01:36:05 volumio-rpib3 sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: VolumeController:: Volume=81 Mute =false Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreStateMachine::pushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioPushState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: adding 9830689a-2dfc-4993-8b9c-91d5afef39a8 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: Found device Volumio-rpib3 Jun 14 01:36:05 volumio-rpib3 systemd[1]: Started UPnP Renderer front-end to MPD. Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 sudo[1468]: pam_unix(sudo:session): session closed for user root Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: this is already registered, 9830689a-2dfc-4993-8b9c-91d5afef39a8 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: Found device Volumio-rpib3 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Upmpdcli Daemon Started Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: this is already registered, 9830689a-2dfc-4993-8b9c-91d5afef39a8 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: Discovery: Found device Volumio-rpib3 Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetState Jun 14 01:36:05 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:05 volumio-rpib3 volumio[1470]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 14 01:36:06 volumio-rpib3 kernel: hwmon hwmon1: Voltage normalised Jun 14 01:36:06 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:36:06] [connect] Successful connection Jun 14 01:36:06 volumio-rpib3 volumio-remote-updater[615]: [2025-06-14 01:36:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749857766 101 Jun 14 01:36:06 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8 Jun 14 01:36:06 volumio-rpib3 volumio[1247]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetState Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getTrack 0 Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: Listing playlists Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetVisibleSources Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::volumioGetQueue Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CoreStateMachine::getQueue Jun 14 01:36:06 volumio-rpib3 volumio[1247]: info: CorePlayQueue::getQueue Jun 14 01:36:09 volumio-rpib3 volumio[1247]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 14 01:36:09 volumio-rpib3 volumio[1247]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 01:36:09 volumio-rpib3 volumio[1247]: TypeError: Cannot read property 'length' of undefined Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at Parser.emit (events.js:315:20) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at IncomingMessage.emit (events.js:327:22) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at endReadableNT (internal/streams/readable.js:1327:12) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 14 01:36:09 volumio-rpib3 volumio[1247]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 01:36:09 volumio-rpib3 volumio[1470]: ...........................++++ Jun 14 01:36:09 volumio-rpib3 sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 01:35 Jun 14 01:36:09 volumio-rpib3 sudo[1509]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"