-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Thu 2024-08-08 10:33:04 CEST. -- Aug 08 10:32:00 volumio wireless.js[646]: trying... Aug 08 10:32:00 volumio sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:00 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:00 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:01 volumio wireless.js[646]: trying... Aug 08 10:32:01 volumio sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:01 volumio sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:01 volumio sudo[1019]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:02 volumio wireless.js[646]: trying... Aug 08 10:32:02 volumio sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:02 volumio sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:02 volumio sudo[1022]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:03 volumio wireless.js[646]: trying... Aug 08 10:32:03 volumio sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:03 volumio sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:03 volumio sudo[1025]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:03 volumio wpa_supplicant[931]: wlan0: Failed to initiate sched scan Aug 08 10:32:04 volumio wireless.js[646]: trying... Aug 08 10:32:04 volumio sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:04 volumio sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:04 volumio sudo[1028]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:05 volumio wireless.js[646]: trying... Aug 08 10:32:05 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:05 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:05 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:06 volumio wireless.js[646]: trying... Aug 08 10:32:06 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:06 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:06 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:07 volumio wireless.js[646]: trying... Aug 08 10:32:07 volumio sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:07 volumio sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:07 volumio sudo[1037]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:08 volumio wireless.js[646]: trying... Aug 08 10:32:08 volumio sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:08 volumio sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:08 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:09 volumio wpa_supplicant[931]: wlan0: Failed to initiate sched scan Aug 08 10:32:09 volumio wireless.js[646]: trying... Aug 08 10:32:09 volumio sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:09 volumio sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:09 volumio sudo[1043]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:09 volumio volumio-remote-updater[651]: [2024-08-08 10:32:09] [info] asio async_connect error: system:111 (Connection refused) Aug 08 10:32:09 volumio volumio-remote-updater[651]: [2024-08-08 10:32:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 08 10:32:09 volumio volumio-remote-updater[651]: [2024-08-08 10:32:09] [error] handle_connect error: Underlying Transport Error Aug 08 10:32:10 volumio wireless.js[646]: trying... Aug 08 10:32:10 volumio sudo[1046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:10 volumio sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:10 volumio sudo[1046]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:11 volumio wireless.js[646]: trying... Aug 08 10:32:11 volumio sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 08 10:32:11 volumio sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:11 volumio sudo[1049]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:12 volumio wireless.js[646]: Overtime, starting plan B Aug 08 10:32:12 volumio wireless.js[646]: STARTING HOTSPOT Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: Failed to set IPv4 unicast in multicast filter Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: Failed to set IPv4 unicast in multicast filter Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 Aug 08 10:32:12 volumio wpa_supplicant[931]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING Aug 08 10:32:12 volumio wpa_supplicant[931]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Aug 08 10:32:13 volumio systemd[1]: systemd-fsckd.service: Succeeded. Aug 08 10:32:13 volumio wpa_supplicant[931]: wlan0: CTRL-EVENT-TERMINATING Aug 08 10:32:15 volumio sudo[1058]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 08 10:32:15 volumio sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:15 volumio sudo[1058]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:15 volumio sudo[1060]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 08 10:32:15 volumio sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:15 volumio sudo[1060]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:15 volumio avahi-daemon[619]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Aug 08 10:32:15 volumio avahi-daemon[619]: New relevant interface wlan0.IPv4 for mDNS. Aug 08 10:32:15 volumio avahi-daemon[619]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Aug 08 10:32:15 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 08 10:32:15 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Aug 08 10:32:15 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Aug 08 10:32:15 volumio dnsmasq[1066]: dnsmasq: syntax check OK. Aug 08 10:32:16 volumio hostapd[1067]: Configuration file: /etc/hostapd/hostapd.conf Aug 08 10:32:16 volumio hostapd[1067]: wlan0: Could not connect to kernel driver Aug 08 10:32:16 volumio hostapd[1067]: Using interface wlan0 with hwaddr b8:27:eb:5a:78:39 and ssid "Volumio-8B31D" Aug 08 10:32:16 volumio dnsmasq[1073]: started, version 2.80 cachesize 150 Aug 08 10:32:16 volumio dnsmasq[1073]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Aug 08 10:32:16 volumio dnsmasq-dhcp[1073]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Aug 08 10:32:16 volumio dnsmasq[1073]: reading /etc/resolv.conf Aug 08 10:32:16 volumio dnsmasq[1073]: using nameserver 208.67.222.222#53 Aug 08 10:32:16 volumio dnsmasq[1073]: using nameserver 208.67.220.220#53 Aug 08 10:32:16 volumio dnsmasq[1073]: using nameserver 212.230.135.1#53 Aug 08 10:32:16 volumio dnsmasq[1073]: using nameserver 212.230.135.2#53 Aug 08 10:32:16 volumio dnsmasq[1073]: read /etc/hosts - 5 addresses Aug 08 10:32:16 volumio dhcpcd[980]: wlan0: carrier acquired Aug 08 10:32:16 volumio hostapd[1067]: wlan0: interface state UNINITIALIZED->ENABLED Aug 08 10:32:16 volumio hostapd[1067]: wlan0: AP-ENABLED Aug 08 10:32:16 volumio dhcpcd[980]: wlan0: IAID eb:5a:78:39 Aug 08 10:32:16 volumio dhcpcd[980]: wlan0: adding address fe80::c923:bd2b:3a55:dcab Aug 08 10:32:16 volumio dhcpcd[980]: ipv6_addaddr1: Permission denied Aug 08 10:32:16 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Aug 08 10:32:16 volumio dhcpcd[980]: wlan0: soliciting a DHCP lease Aug 08 10:32:16 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Aug 08 10:32:16 volumio systemd[1]: Reached target Host and Network Name Lookups. Aug 08 10:32:16 volumio iwconfig[1082]: Error for wireless request "Set Power Management" (8B2C) : Aug 08 10:32:16 volumio iwconfig[1082]: SET failed on device wlan0 ; Invalid argument. Aug 08 10:32:16 volumio systemd[1]: Started Wireless Services. Aug 08 10:32:16 volumio systemd[1]: Started Volumio Backend Module. Aug 08 10:32:16 volumio systemd[1]: Started Volumio Cpu Tweaker. Aug 08 10:32:16 volumio systemd[1]: Reached target Multi-User System. Aug 08 10:32:16 volumio systemd[1]: Reached target Graphical Interface. Aug 08 10:32:16 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 08 10:32:16 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: Setting RT Priority for mpd Aug 08 10:32:16 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 08 10:32:16 volumio systemd[1]: Startup finished in 17.752s (kernel) + 38.538s (userspace) = 56.290s. Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: pid 35's current scheduling policy: SCHED_OTHER Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: pid 35's current scheduling priority: 0 Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: Setting MPD Affinity Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: pid 3's current affinity mask: f Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 08 10:32:16 volumio volumio-cpu-tweak[1084]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Aug 08 10:32:16 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 08 10:32:17 volumio dhcpcd[980]: wlan0: soliciting an IPv6 router Aug 08 10:32:17 volumio ntpd[802]: Listen normally on 4 wlan0 192.168.211.1:123 Aug 08 10:32:17 volumio ntpd[802]: new interface(s) found: waking up resolver Aug 08 10:32:18 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 08 10:32:19 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:19 volumio volumio[1083]: info: ----- Volumio3 ---- Aug 08 10:32:19 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:19 volumio volumio[1083]: info: ----- System startup ---- Aug 08 10:32:19 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:19 volumio volumio-remote-updater[651]: [2024-08-08 10:32:19] [connect] Successful connection Aug 08 10:32:20 volumio volumio[1083]: info: MYVOLUMIO Environment detected Aug 08 10:32:20 volumio volumio[1083]: info: Plugin folders cleanup Aug 08 10:32:20 volumio volumio[1083]: info: Scanning into folder /volumio/app/plugins/ Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category audio_interface Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category miscellanea Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category music_service Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category plugins.json Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category system_controller Aug 08 10:32:20 volumio volumio[1083]: info: Scanning category user_interface Aug 08 10:32:20 volumio volumio[1083]: info: Scanning into folder /data/plugins/ Aug 08 10:32:20 volumio volumio[1083]: info: Plugin folders cleanup completed Aug 08 10:32:20 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:20 volumio volumio[1083]: info: ----- Core plugins startup ---- Aug 08 10:32:20 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:20 volumio volumio[1083]: info: Loading plugins from folder /volumio/app/plugins/ Aug 08 10:32:20 volumio volumio[1083]: info: Adding plugin upnp to MyMusic Plugins Aug 08 10:32:20 volumio volumio[1083]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 08 10:32:20 volumio volumio[1083]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 08 10:32:20 volumio volumio[1083]: info: Loading plugins from folder /data/plugins/ Aug 08 10:32:20 volumio volumio[1083]: info: Loading plugin "system"... Aug 08 10:32:20 volumio volumio[1083]: info: Loading plugin "appearance"... Aug 08 10:32:21 volumio dhcpcd[980]: wlan0: probing for an IPv4LL address Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "network"... Aug 08 10:32:22 volumio volumio[1083]: info: Refreshing Cached IP Addresses Aug 08 10:32:22 volumio sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 08 10:32:22 volumio sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio sudo[1117]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:22 volumio sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "services"... Aug 08 10:32:22 volumio sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "alsa_controller"... Aug 08 10:32:22 volumio sudo[1119]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:22 volumio sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 08 10:32:22 volumio sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio sudo[1122]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:22 volumio kernel: ieee80211 phy0: brcmf_vif_set_mgmt_ie: vndr ie set error : -52 Aug 08 10:32:22 volumio kernel: ieee80211 phy0: brcmf_cfg80211_scan: scan error (-52) Aug 08 10:32:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "wizard"... Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "networkfs"... Aug 08 10:32:22 volumio sudo[1128]: 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.1.249/Música /mnt/NAS/Música Aug 08 10:32:22 volumio sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio volumio[1083]: info: Starting Udev Watcher for removable devices Aug 08 10:32:22 volumio sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mario,password=31213121,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.134/Música tradicional /mnt/NAS/Música_tradicional Aug 08 10:32:22 volumio sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio sudo[1133]: 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.1.168/nobody /mnt/NAS/nobody Aug 08 10:32:22 volumio sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:22 volumio volumio[1083]: info: Ignoring mount for partition: boot Aug 08 10:32:22 volumio volumio[1083]: info: Ignoring mount for partition: volumio Aug 08 10:32:22 volumio volumio[1083]: info: Ignoring mount for partition: volumio_data Aug 08 10:32:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "volumio_command_line_client"... Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "upnp"... Aug 08 10:32:22 volumio volumio[1083]: info: [1723105942605] Starting Upmpd Daemon Aug 08 10:32:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "my_music"... Aug 08 10:32:22 volumio volumio[1083]: info: Loading plugin "mpd"... Aug 08 10:32:22 volumio kernel: Key type cifs.spnego registered Aug 08 10:32:22 volumio kernel: Key type cifs.idmap registered Aug 08 10:32:22 volumio 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. Aug 08 10:32:22 volumio kernel: CIFS: Attempting to mount \\192.168.1.249\Música Aug 08 10:32:22 volumio sudo[1128]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:22 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:22 volumio kernel: CIFS: Attempting to mount \\192.168.1.134\Música tradicional Aug 08 10:32:22 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.134\Música tradicional Aug 08 10:32:22 volumio sudo[1130]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:22 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Aug 08 10:32:22 volumio kernel: CIFS: Attempting to mount \\192.168.1.168\nobody Aug 08 10:32:23 volumio volumio[1083]: info: Loading plugin "upnp_browser"... Aug 08 10:32:23 volumio volumio[1083]: info: Loading plugin "alarm-clock"... Aug 08 10:32:23 volumio volumio[1083]: info: Loading plugin "airplay_emulation"... Aug 08 10:32:23 volumio volumio[1083]: info: Starting Shairport Sync Aug 08 10:32:23 volumio volumio[1083]: info: Loading plugin "last_100"... Aug 08 10:32:23 volumio volumio[1083]: info: Loading plugin "webradio"... Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "i2s_dacs"... Aug 08 10:32:24 volumio sudo[1133]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:24 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "volumiodiscovery"... Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** For more information see Aug 08 10:32:24 volumio node[1083]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 10:32:24 volumio volumio[1083]: *** WARNING *** For more information see Aug 08 10:32:24 volumio node[1083]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 10:32:24 volumio node[1083]: *** WARNING *** For more information see Aug 08 10:32:24 volumio node[1083]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 08 10:32:24 volumio node[1083]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 10:32:24 volumio node[1083]: *** WARNING *** For more information see Aug 08 10:32:24 volumio volumio[1083]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 08 10:32:24 volumio volumio[1083]: info: Discovery: Started advertising with name: Volumio Aug 08 10:32:24 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "outputs"... Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "albumart"... Aug 08 10:32:24 volumio volumio[1083]: info: Plugin example_plugin is not enabled Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "inputs"... Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "updater_comm"... Aug 08 10:32:24 volumio volumio[1083]: info: Plugin mpdemulation is not enabled Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "rest_api"... Aug 08 10:32:24 volumio volumio[1083]: info: Loading plugin "websocket"... Aug 08 10:32:24 volumio volumio[1083]: info: Starting Socket.io Server version 2.3.0 Aug 08 10:32:24 volumio volumio[1083]: info: Loading i18n strings for locale es Aug 08 10:32:24 volumio volumio[1083]: Updating browse sources language Aug 08 10:32:24 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:24 volumio volumio[1083]: Forking 3 albumart workers Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::initPlayerControls Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 10:32:25 volumio volumio[1083]: Express server listening on port 3000 Aug 08 10:32:25 volumio volumio[1083]: [Metrics] WebUI: 6s 884.49ms Aug 08 10:32:25 volumio volumio[1083]: info: CoreStateMachine::resetVolumioState Aug 08 10:32:25 volumio volumio[1083]: info: CoreStateMachine::getcurrentVolume Aug 08 10:32:25 volumio volumio[1083]: info: CoreCommandRouter::volumioRetrievevolume Aug 08 10:32:25 volumio volumio[1083]: info: Cannot mount NAS nobody at system boot, trial number 1 ,retrying in 5 seconds Aug 08 10:32:25 volumio volumio[1083]: info: Cannot mount NAS Música_tradicional at system boot, trial number 1 ,retrying in 5 seconds Aug 08 10:32:25 volumio volumio[1083]: info: Cannot mount NAS Música at system boot, trial number 1 ,retrying in 5 seconds Aug 08 10:32:25 volumio volumio[1083]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Aug 08 10:32:25 volumio volumio[1083]: wlan0 Interface doesn't support scanning : Invalid exchange Aug 08 10:32:25 volumio volumio[1083]: info: Cannot use regular scanning, forcing with ap-force Aug 08 10:32:25 volumio sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Aug 08 10:32:25 volumio sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:25 volumio volumio[1083]: Starting albumart workers Aug 08 10:32:25 volumio volumio[1083]: Starting albumart workers Aug 08 10:32:25 volumio volumio[1083]: Starting albumart workers Aug 08 10:32:26 volumio sudo[1208]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioRetrievevolume Aug 08 10:32:26 volumio dhcpcd[980]: wlan0: using IPv4LL address 169.254.136.195 Aug 08 10:32:26 volumio avahi-daemon[619]: Registering new address record for 169.254.136.195 on wlan0.IPv4. Aug 08 10:32:26 volumio dhcpcd[980]: wlan0: adding route to 169.254.0.0/16 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:26 volumio volumio[1083]: info: Reloading queue from file Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 11 Aug 08 10:32:26 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetVisibleSources Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 08 10:32:26 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: Listing playlists Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::setRepeat false single undefined Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::setRandom false Aug 08 10:32:26 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:26 volumio volumio[1083]: info: Setting Device type: Raspberry PI Aug 08 10:32:26 volumio volumio[1083]: info: Completed loading Core Plugins Aug 08 10:32:26 volumio volumio[1083]: info: Preparing to generate the ALSA configuration file Aug 08 10:32:26 volumio volumio[1083]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Aug 08 10:32:26 volumio volumio[1083]: info: Reading ALSA contributions from plugins. Aug 08 10:32:26 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 12 Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: adding 220075b8-e506-4b2d-8d8f-c090180ac9b0 Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: Found device Volumio Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: this is already registered, 220075b8-e506-4b2d-8d8f-c090180ac9b0 Aug 08 10:32:26 volumio volumio[1083]: info: Discovery: Found device Volumio Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:26 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:26 volumio volumio[1083]: info: Asound.conf file unchanged, so no further update is needed Aug 08 10:32:26 volumio volumio[1083]: info: Output device has changed, restarting MPD Aug 08 10:32:26 volumio volumio[1083]: info: Output device has changed, restarting Shairport Sync Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:26 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:26 volumio sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 08 10:32:26 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:26 volumio sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 08 10:32:26 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:26 volumio sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:26 volumio volumio[1083]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 10:32:26 volumio volumio[1083]: info: ___________ START PLUGINS ___________ Aug 08 10:32:26 volumio volumio[1083]: info: ControllerMpd::onStart: Initializing MPD Aug 08 10:32:26 volumio volumio[1083]: info: Creating MPD Configuration file Aug 08 10:32:27 volumio systemd[1]: Listening on mpd.socket. Aug 08 10:32:27 volumio systemd[1]: Starting Music Player Daemon... Aug 08 10:32:27 volumio sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 08 10:32:27 volumio sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 10:32:27 volumio volumio[1083]: info: [1723105947043] CoreMusicLibrary::Adding element Media Servers Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:27 volumio sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 08 10:32:27 volumio sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1275]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:27 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 08 10:32:27 volumio systemd[1]: mpd.service: Succeeded. Aug 08 10:32:27 volumio systemd[1]: Stopped Music Player Daemon. Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:27 volumio systemd[1]: Starting Music Player Daemon... Aug 08 10:32:27 volumio volumio[1083]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 10:32:27 volumio volumio[1083]: info: [1723105947182] CoreMusicLibrary::Adding element Last_100 Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 10:32:27 volumio volumio[1083]: info: [1723105947186] CoreMusicLibrary::Adding element Webradio Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 10:32:27 volumio volumio[1083]: info: Initializing BBC Radios Aug 08 10:32:27 volumio sudo[1281]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 08 10:32:27 volumio sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1281]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 08 10:32:27 volumio sudo[1281]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: Volumio Calling Home Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:27 volumio volumio[1083]: info: MPD Permissions set Aug 08 10:32:27 volumio volumio[1083]: info: MPD Permissions set Aug 08 10:32:27 volumio volumio[1083]: info: Volumio called home Aug 08 10:32:27 volumio volumio[1083]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:27 volumio ntpd[802]: Listen normally on 5 wlan0 169.254.136.195:123 Aug 08 10:32:27 volumio ntpd[802]: new interface(s) found: waking up resolver Aug 08 10:32:27 volumio volumio[1083]: info: Starting Shairport Sync Aug 08 10:32:27 volumio sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 08 10:32:27 volumio sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1312]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:27 volumio sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 08 10:32:27 volumio sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1314]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:27 volumio volumio[1083]: info: Starting Shairport Sync Aug 08 10:32:27 volumio volumio[1083]: info: Starting Shairport Sync Aug 08 10:32:27 volumio sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 10:32:27 volumio sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 10:32:27 volumio sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 10:32:27 volumio sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:27 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 08 10:32:28 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 08 10:32:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 08 10:32:28 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:28 volumio sudo[1320]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:28 volumio sudo[1322]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:28 volumio volumio[1083]: info: Shairport-Sync Started Aug 08 10:32:28 volumio volumio[1083]: Error adding Membership: Error: addMembership EINVAL Aug 08 10:32:28 volumio volumio[1083]: info: Shairport-Sync Started Aug 08 10:32:28 volumio volumio[1083]: info: Shairport-Sync Started Aug 08 10:32:28 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Avast/133.0.0.0 Engine version: 3 Transport: polling Total Clients: 14 Aug 08 10:32:28 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:28 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetVisibleSources Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 08 10:32:28 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:28 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:28 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:28 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:28 volumio volumio[1083]: info: Listing playlists Aug 08 10:32:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 08 10:32:29 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:29 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:29 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:29 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 08 10:32:30 volumio sudo[1330]: 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.1.168/nobody /mnt/NAS/nobody Aug 08 10:32:30 volumio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:30 volumio kernel: CIFS: Attempting to mount \\192.168.1.168\nobody Aug 08 10:32:30 volumio sudo[1336]: 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.1.249/Música /mnt/NAS/Música Aug 08 10:32:30 volumio sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:30 volumio sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mario,password=31213121,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.134/Música tradicional /mnt/NAS/Música_tradicional Aug 08 10:32:30 volumio sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 08 10:32:30 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:30 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:30 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:30 volumio mpd[1291]: Aug 08 10:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 08 10:32:30 volumio systemd[1]: Started Music Player Daemon. Aug 08 10:32:30 volumio sudo[1267]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:30 volumio sudo[1277]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:30 volumio volumio[1083]: info: Completed starting Core Plugins Aug 08 10:32:30 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:30 volumio volumio[1083]: info: ----- MyVolumio plugins startup ---- Aug 08 10:32:30 volumio volumio[1083]: info: ------------------------------------------- Aug 08 10:32:30 volumio volumio[1083]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 08 10:32:30 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:30 volumio kernel: CIFS: Attempting to mount \\192.168.1.249\Música Aug 08 10:32:30 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:30 volumio sudo[1336]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:30 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:30 volumio kernel: CIFS: Attempting to mount \\192.168.1.134\Música tradicional Aug 08 10:32:30 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.134\Música tradicional Aug 08 10:32:30 volumio sudo[1332]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:30 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Aug 08 10:32:30 volumio volumio[1083]: error: MPD error: The expression evaluated to a falsy value: Aug 08 10:32:30 volumio volumio[1083]: assert.ok(self.idling) Aug 08 10:32:30 volumio volumio[1083]: error: The expression evaluated to a falsy value: Aug 08 10:32:30 volumio volumio[1083]: assert.ok(self.idling) Aug 08 10:32:30 volumio volumio[1083]: info: MPD running with PID1291 Aug 08 10:32:30 volumio volumio[1083]: ,establishing connection Aug 08 10:32:30 volumio volumio[1083]: error: updateQueue error: null Aug 08 10:32:30 volumio volumio[1083]: info: Cannot mount NAS Música_tradicional at system boot, trial number 2 ,retrying in 5 seconds Aug 08 10:32:30 volumio volumio[1083]: info: Cannot mount NAS Música at system boot, trial number 2 ,retrying in 5 seconds Aug 08 10:32:30 volumio volumio[1083]: info: Cannot mount NAS nobody at system boot, trial number 2 ,retrying in 5 seconds Aug 08 10:32:30 volumio volumio[1083]: error: updateQueue error: null Aug 08 10:32:30 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 08 10:32:32 volumio sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 08 10:32:32 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:32 volumio sudo[1352]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:32 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 08 10:32:32 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:32 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:32 volumio sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 08 10:32:32 volumio sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:32 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 08 10:32:32 volumio sudo[1357]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:32 volumio volumio[1083]: info: Upmpdcli Daemon Started Aug 08 10:32:32 volumio volumio[1360]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 08 10:32:34 volumio volumio-remote-updater[651]: [2024-08-08 10:32:34] [connect] Successful connection Aug 08 10:32:34 volumio volumio-remote-updater[651]: [2024-08-08 10:32:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723105954 101 Aug 08 10:32:34 volumio volumio[1083]: 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: 15 Aug 08 10:32:35 volumio volumio[1083]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 08 10:32:35 volumio sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mario,password=31213121,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.134/Música tradicional /mnt/NAS/Música_tradicional Aug 08 10:32:35 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:35 volumio sudo[1379]: 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.1.249/Música /mnt/NAS/Música Aug 08 10:32:35 volumio sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:35 volumio kernel: CIFS: Attempting to mount \\192.168.1.134\Música tradicional Aug 08 10:32:35 volumio sudo[1384]: 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.1.168/nobody /mnt/NAS/nobody Aug 08 10:32:35 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:35 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.134\Música tradicional Aug 08 10:32:35 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:35 volumio volumio[1083]: info: Cannot mount NAS Música_tradicional at system boot, trial number 3 ,retrying in 5 seconds Aug 08 10:32:35 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Aug 08 10:32:35 volumio kernel: CIFS: Attempting to mount \\192.168.1.249\Música Aug 08 10:32:35 volumio sudo[1379]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:35 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:35 volumio kernel: CIFS: Attempting to mount \\192.168.1.168\nobody Aug 08 10:32:35 volumio volumio[1083]: info: Cannot mount NAS Música at system boot, trial number 3 ,retrying in 5 seconds Aug 08 10:32:35 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:35 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:35 volumio volumio[1083]: info: Cannot mount NAS nobody at system boot, trial number 3 ,retrying in 5 seconds Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::play index undefined Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::startPlaybackTimer Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::clearAddPlayTracks NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3 Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand stop took 3 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clear Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand clear took 4 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand add "NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3" Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: error: updateQueue error: null Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 13ms Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand add "NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3" took 10 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 9ms Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 7ms Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand play Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Aug 08 10:32:37 volumio volumio[1083]: info: Ignoring MPD Status Update Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 12ms Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand play took 8 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces state update: player Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::getState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces state update: player Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::getState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 15ms Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 13ms Aug 08 10:32:37 volumio volumio[1083]: info: Aug 08 10:32:37 volumio volumio[1083]: ---------------------------- MPD announces state update: player Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::getState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand status took 17 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand status took 25 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand status took 22 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand clearerror took 14 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseState Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"'5 - Almogía","artist":"Panda de Verdiales Raices de Almogía","album":"Panda de Verdiales Raices de Almogía","uri":"NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3","trackType":"mp3"} Aug 08 10:32:37 volumio volumio[1083]: verbose: CURRENT POSITION 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: No code Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 86ms Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand clearerror took 61 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand clearerror took 60 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 54 milliseconds Aug 08 10:32:37 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 53 milliseconds Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Aug 08 10:32:37 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"'5 - Almogía","artist":"Panda de Verdiales Raices de Almogía","album":"Panda de Verdiales Raices de Almogía","uri":"NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3","trackType":"mp3"} Aug 08 10:32:37 volumio volumio[1083]: verbose: CURRENT POSITION 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: No code Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: ControllerMpd::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"'5 - Almogía","artist":"Panda de Verdiales Raices de Almogía","album":"Panda de Verdiales Raices de Almogía","uri":"NAS/m/Comares - Verdiales - Málaga/'5 - Almogía.mp3","trackType":"mp3"} Aug 08 10:32:37 volumio volumio[1083]: verbose: CURRENT POSITION 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: No code Aug 08 10:32:37 volumio volumio[1083]: info: CoreStateMachine::pushState Aug 08 10:32:37 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:37 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 161ms Aug 08 10:32:37 volumio volumio[1083]: info: ------------------------------ 158ms Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 08 10:32:40 volumio sudo[1401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mario,password=31213121,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.134/Música tradicional /mnt/NAS/Música_tradicional Aug 08 10:32:40 volumio sudo[1401]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:40 volumio sudo[1403]: 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.1.249/Música /mnt/NAS/Música Aug 08 10:32:40 volumio kernel: CIFS: Attempting to mount \\192.168.1.134\Música tradicional Aug 08 10:32:40 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:40 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.134\Música tradicional Aug 08 10:32:40 volumio sudo[1401]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:40 volumio volumio[1083]: info: Cannot mount NAS Música_tradicional at system boot, trial number 4 ,retrying in 5 seconds Aug 08 10:32:40 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Aug 08 10:32:40 volumio kernel: CIFS: Attempting to mount \\192.168.1.249\Música Aug 08 10:32:40 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:40 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:40 volumio volumio[1083]: info: Cannot mount NAS Música at system boot, trial number 4 ,retrying in 5 seconds Aug 08 10:32:40 volumio sudo[1413]: 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.1.168/nobody /mnt/NAS/nobody Aug 08 10:32:40 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:40 volumio kernel: CIFS: Attempting to mount \\192.168.1.168\nobody Aug 08 10:32:40 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:40 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:40 volumio volumio[1083]: info: Cannot mount NAS nobody at system boot, trial number 4 ,retrying in 5 seconds Aug 08 10:32:45 volumio sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=mario,password=31213121,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.134/Música tradicional /mnt/NAS/Música_tradicional Aug 08 10:32:45 volumio sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:45 volumio sudo[1421]: 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.1.249/Música /mnt/NAS/Música Aug 08 10:32:45 volumio kernel: CIFS: Attempting to mount \\192.168.1.134\Música tradicional Aug 08 10:32:45 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:45 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.134\Música tradicional Aug 08 10:32:45 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Aug 08 10:32:45 volumio sudo[1419]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:45 volumio volumio[1083]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 08 10:32:45 volumio kernel: CIFS: Attempting to mount \\192.168.1.249\Música Aug 08 10:32:45 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:45 volumio volumio[1083]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 08 10:32:45 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:45 volumio sudo[1431]: 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.1.168/nobody /mnt/NAS/nobody Aug 08 10:32:45 volumio sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 10:32:45 volumio kernel: CIFS: Attempting to mount \\192.168.1.168\nobody Aug 08 10:32:46 volumio sudo[1431]: pam_unix(sudo:session): session closed for user root Aug 08 10:32:46 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 08 10:32:46 volumio volumio[1083]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 08 10:32:46 volumio volumio[1083]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 08 10:32:46 volumio volumio[1083]: info: Received Get System Version Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 10:32:46 volumio volumio[1083]: info: Received Get System Info Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:32:46 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:46 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:46 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:32:48 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:32:48 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:32:50 volumio volumio[1083]: error: MyVolumio Plugin failed to start in a timely fashion Aug 08 10:32:50 volumio volumio[1083]: info: BOOT COMPLETED Aug 08 10:32:50 volumio volumio[1083]: [Metrics] CommandRouter: 31s 255.35ms Aug 08 10:32:50 volumio volumio[1083]: info: CoreCommandRouter::volumiosetStartupVolume Aug 08 10:32:50 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 10:32:50 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:50 volumio volumio[1083]: info: CoreCommandRouter::Close All Modals sent Aug 08 10:32:50 volumio volumio[1083]: info: CoreCommandRouter::Close All Modals sent Aug 08 10:32:51 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 08 10:32:51 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 08 10:32:51 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 08 10:32:53 volumio volumio[1083]: info: CoreCommandRouter::volumioGetQueue Aug 08 10:32:53 volumio volumio[1083]: info: CoreStateMachine::getQueue Aug 08 10:32:53 volumio volumio[1083]: info: CorePlayQueue::getQueue Aug 08 10:32:53 volumio ntpd[802]: Soliciting pool server 217.71.200.210 Aug 08 10:32:53 volumio ntpd[802]: Soliciting pool server 195.95.153.59 Aug 08 10:32:54 volumio ntpd[802]: Soliciting pool server 84.77.195.114 Aug 08 10:32:54 volumio volumio[1360]: .................................................................................................................................................................++++ Aug 08 10:32:55 volumio ntpd[802]: Soliciting pool server 90.68.206.60 Aug 08 10:32:56 volumio ntpd[802]: Soliciting pool server 82.223.203.159 Aug 08 10:32:57 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 10:32:57 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 10:32:57 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 08 10:32:57 volumio ntpd[802]: Soliciting pool server 185.198.109.227 Aug 08 10:32:57 volumio ntpd[802]: Soliciting pool server 217.160.163.33 Aug 08 10:32:58 volumio ntpd[802]: Soliciting pool server 162.159.200.1 Aug 08 10:32:58 volumio ntpd[802]: Soliciting pool server 162.159.200.123 Aug 08 10:32:59 volumio ntpd[802]: Soliciting pool server 94.143.139.219 Aug 08 10:33:00 volumio volumio[1083]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.135 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: Received Get System Info Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:33:00 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetVisibleSources Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 08 10:33:00 volumio volumio[1083]: info: Received Get System Info Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 10:33:00 volumio volumio[1083]: info: Discovery: Getting this device information Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 10:33:00 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Aug 08 10:33:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Aug 08 10:33:00 volumio volumio[1083]: info: Listing playlists Aug 08 10:33:00 volumio ntpd[802]: Soliciting pool server 2001:ba0:21f:4900::2 Aug 08 10:33:01 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 08 10:33:01 volumio volumio[1083]: info: Preload queue cleared Aug 08 10:33:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 08 10:33:03 volumio volumio[1083]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 08 10:33:03 volumio volumio[1083]: TypeError: Cannot read property 'length' of undefined Aug 08 10:33:03 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Aug 08 10:33:03 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Aug 08 10:33:03 volumio volumio[1083]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Aug 08 10:33:03 volumio volumio[1083]: at Parser.emit (events.js:315:20) Aug 08 10:33:03 volumio volumio[1083]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Aug 08 10:33:03 volumio volumio[1083]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Aug 08 10:33:03 volumio volumio[1083]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Aug 08 10:33:03 volumio volumio[1083]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Aug 08 10:33:03 volumio volumio[1083]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Aug 08 10:33:03 volumio volumio[1083]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Aug 08 10:33:03 volumio volumio[1083]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Aug 08 10:33:03 volumio volumio[1083]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Aug 08 10:33:03 volumio volumio[1083]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Aug 08 10:33:03 volumio volumio[1083]: at IncomingMessage.emit (events.js:327:22) Aug 08 10:33:03 volumio volumio[1083]: at endReadableNT (internal/streams/readable.js:1327:12) Aug 08 10:33:03 volumio volumio[1083]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 08 10:33:03 volumio volumio[1083]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 08 10:33:04 volumio sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-08 10:32 Aug 08 10:33:04 volumio sudo[1487]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"