-- Logs begin at Mon 2025-03-03 12:04:54 EET, end at Mon 2025-03-03 12:06:00 EET. -- Mar 03 12:05:00 volumio ifplugd(eth0)[731]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Mar 03 12:05:00 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 03 12:05:00 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 03 12:05:00 volumio sudo[696]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 12:05:00 volumio sudo[696]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:00 volumio systemd[1]: Starting Hostname Service... Mar 03 12:05:00 volumio sudo[696]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 03 12:05:00 volumio sudo[696]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:00 volumio sshd[758]: Server listening on 0.0.0.0 port 22. Mar 03 12:05:00 volumio sshd[758]: Server listening on :: port 22. Mar 03 12:05:00 volumio systemd[1]: Started OpenBSD Secure Shell server. Mar 03 12:05:00 volumio cpufrequtils[759]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 03 12:05:00 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 03 12:05:00 volumio dbus-daemon[551]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 03 12:05:00 volumio systemd[1]: Started Hostname Service. Mar 03 12:05:00 volumio ntpd[733]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 03 12:05:01 volumio nmbd[700]: [2025/03/03 12:05:01.110215, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 03 12:05:01 volumio nmbd[700]: started asyncdns process 775 Mar 03 12:05:01 volumio nmbd[700]: [2025/03/03 12:05:01.112382, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 03 12:05:01 volumio nmbd[700]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 03 12:05:01 volumio nmbd[700]: [2025/03/03 12:05:01.112549, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 03 12:05:01 volumio nmbd[700]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 03 12:05:01 volumio systemd[1]: systemd-rfkill.service: Succeeded. Mar 03 12:05:01 volumio wireless.js[555]: WIRELESS: No wireless interface, exiting Mar 03 12:05:01 volumio iw[780]: command failed: No such device (-19) Mar 03 12:05:01 volumio iwconfig[783]: Error for wireless request "Set Power Management" (8B2C) : Mar 03 12:05:01 volumio iwconfig[783]: SET failed on device wlan0 ; No such device. Mar 03 12:05:01 volumio systemd[1]: wireless.service: Succeeded. Mar 03 12:05:01 volumio systemd[1]: Started Wireless Services. Mar 03 12:05:01 volumio systemd[1]: Started Volumio Backend Module. Mar 03 12:05:01 volumio systemd[1]: Started Volumio Cpu Tweaker. Mar 03 12:05:01 volumio ntpd[733]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: Setting RT Priority for mpd Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: Setting MPD Affinity Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: pid 764's current affinity mask: f Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: pid 764's new affinity mask: 3 Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 03 12:05:01 volumio volumio-cpu-tweak[787]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 03 12:05:01 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 03 12:05:02 volumio ntpd[733]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 03 12:05:03 volumio volumio-remote-updater[556]: [2025-03-03 12:05:03] [info] asio async_connect error: system:111 (Connection refused) Mar 03 12:05:03 volumio volumio-remote-updater[556]: [2025-03-03 12:05:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 03 12:05:03 volumio volumio-remote-updater[556]: [2025-03-03 12:05:03] [error] handle_connect error: Underlying Transport Error Mar 03 12:05:03 volumio volumio-time-update[537]: volumio-time-update-util: Fetching time from Volumio... Mar 03 12:05:03 volumio volumio-time-update[537]: volumio-time-update-util: Date not found in response Mar 03 12:05:03 volumio volumio-time-update[537]: volumio-time-update-util: Retrying in 5 seconds... Mar 03 12:05:03 volumio ntpd[733]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 03 12:05:04 volumio sh[506]: eth0: leased 192.168.0.101 for 86400 seconds Mar 03 12:05:04 volumio sh[506]: eth0: adding route to 192.168.0.0/24 Mar 03 12:05:04 volumio sh[506]: eth0: adding default route via 192.168.0.1 Mar 03 12:05:04 volumio dhcpcd[617]: eth0: leased 192.168.0.101 for 86400 seconds Mar 03 12:05:04 volumio dhcpcd[617]: eth0: adding route to 192.168.0.0/24 Mar 03 12:05:04 volumio dhcpcd[617]: eth0: adding default route via 192.168.0.1 Mar 03 12:05:04 volumio avahi-daemon[557]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.101. Mar 03 12:05:04 volumio avahi-daemon[557]: New relevant interface eth0.IPv4 for mDNS. Mar 03 12:05:04 volumio avahi-daemon[557]: Registering new address record for 192.168.0.101 on eth0.IPv4. Mar 03 12:05:04 volumio sh[506]: forked to background, child pid 828 Mar 03 12:05:04 volumio dhcpcd[617]: forked to background, child pid 828 Mar 03 12:05:04 volumio mpd[764]: Mar 03 12:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 12:05:04 volumio ifplugd(eth0)[731]: client: ifup: interface eth0 already configured Mar 03 12:05:04 volumio sh[506]: eth0=eth0 Mar 03 12:05:04 volumio systemd[1]: Started Music Player Daemon. Mar 03 12:05:04 volumio mpd_monitor.sh[541]: MPD restarted due to no mpc output. Mar 03 12:05:04 volumio ifplugd(eth0)[731]: Program executed successfully. Mar 03 12:05:04 volumio ifplugd[691]: Network Interface Plugging Daemon...start eth0...done. Mar 03 12:05:04 volumio systemd[1]: Started LSB: Brings up/down network automatically. Mar 03 12:05:05 volumio ntpd[733]: Listen normally on 3 eth0 192.168.0.101:123 Mar 03 12:05:05 volumio ntpd[733]: new interface(s) found: waking up resolver Mar 03 12:05:05 volumio volumio[786]: info: ------------------------------------------- Mar 03 12:05:05 volumio volumio[786]: info: ----- Volumio3 ---- Mar 03 12:05:05 volumio volumio[786]: info: ------------------------------------------- Mar 03 12:05:05 volumio volumio[786]: info: ----- System startup ---- Mar 03 12:05:05 volumio volumio[786]: info: ------------------------------------------- Mar 03 12:05:06 volumio nmbd[700]: [2025/03/03 12:05:06.118261, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 12:05:06 volumio nmbd[700]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 03 12:05:06 volumio systemd[1]: Started Samba NMB Daemon. Mar 03 12:05:06 volumio systemd[1]: Starting Samba Winbind Daemon... Mar 03 12:05:06 volumio winbindd[865]: [2025/03/03 12:05:06.521142, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 03 12:05:06 volumio winbindd[865]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 03 12:05:07 volumio winbindd[865]: [2025/03/03 12:05:07.403578, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 12:05:07 volumio winbindd[865]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 03 12:05:07 volumio systemd[1]: Started Samba Winbind Daemon. Mar 03 12:05:07 volumio systemd[1]: Starting Samba SMB Daemon... Mar 03 12:05:08 volumio volumio-time-update[537]: volumio-time-update-util: Fetching time from Volumio... Mar 03 12:05:08 volumio volumio-time-update[537]: volumio-time-update-util: Setting system time to: 2025-03-03 12:05:32 Mar 03 12:05:08 volumio sudo[880]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-03 12:05:32 Mar 03 12:05:08 volumio sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:09 volumio dbus-daemon[551]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.7' (uid=0 pid=881 comm="timedatectl set-time 2025-03-03 12:05:32 ") Mar 03 12:05:10 volumio smbd[870]: [2025/03/03 12:05:10.498179, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 12:05:10 volumio smbd[870]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 03 12:05:10 volumio volumio[786]: info: MYVOLUMIO Environment detected Mar 03 12:05:10 volumio systemd[1]: Starting Time & Date Service... Mar 03 12:05:10 volumio systemd[1]: Started Samba SMB Daemon. Mar 03 12:05:10 volumio dbus-daemon[551]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 03 12:05:10 volumio systemd[1]: Started Time & Date Service. Mar 03 12:05:10 volumio volumio[786]: info: Plugin folders cleanup Mar 03 12:05:10 volumio volumio[786]: info: Scanning into folder /volumio/app/plugins/ Mar 03 12:05:10 volumio volumio[786]: info: Scanning category audio_interface Mar 03 12:05:10 volumio volumio[786]: info: Scanning category miscellanea Mar 03 12:05:10 volumio volumio[786]: info: Scanning category music_service Mar 03 12:05:10 volumio volumio[786]: info: Scanning category plugins.json Mar 03 12:05:10 volumio volumio[786]: info: Scanning category system_controller Mar 03 12:05:10 volumio volumio[786]: info: Scanning category user_interface Mar 03 12:05:32 volumio systemd-timedated[885]: Changed local time to Mon Mar 3 12:05:32 2025 Mar 03 12:05:32 volumio volumio[786]: info: Scanning into folder /data/plugins/ Mar 03 12:05:32 volumio volumio[786]: info: Scanning category music_service Mar 03 12:05:32 volumio sudo[880]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:32 volumio volumio[786]: info: Scanning category user_interface Mar 03 12:05:32 volumio volumio[786]: info: Plugin folders cleanup completed Mar 03 12:05:32 volumio volumio-time-update[537]: volumio-time-update-util: System time updated successfully. Mar 03 12:05:32 volumio volumio[786]: info: ------------------------------------------- Mar 03 12:05:32 volumio volumio[786]: info: ----- Core plugins startup ---- Mar 03 12:05:32 volumio volumio[786]: info: ------------------------------------------- Mar 03 12:05:32 volumio systemd[1]: Started Volumio Time Update Utility. Mar 03 12:05:32 volumio volumio[786]: info: Loading plugins from folder /volumio/app/plugins/ Mar 03 12:05:32 volumio systemd[1]: Reached target Multi-User System. Mar 03 12:05:32 volumio systemd[1]: Reached target Graphical Interface. Mar 03 12:05:32 volumio volumio[786]: info: Adding plugin upnp to MyMusic Plugins Mar 03 12:05:32 volumio volumio[786]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 03 12:05:32 volumio volumio[786]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 03 12:05:32 volumio volumio[786]: info: Loading plugins from folder /data/plugins/ Mar 03 12:05:32 volumio volumio[786]: info: Loading plugin "system"... Mar 03 12:05:32 volumio volumio[786]: info: Loading plugin "appearance"... Mar 03 12:05:32 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 03 12:05:32 volumio volumio-remote-updater[556]: [2025-03-03 12:05:32] [connect] Successful connection Mar 03 12:05:32 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 03 12:05:32 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 03 12:05:32 volumio systemd[1]: Startup finished in 14.858s (kernel) + 18.261s (userspace) = 33.120s. Mar 03 12:05:33 volumio volumio[786]: info: Loading plugin "network"... Mar 03 12:05:33 volumio volumio[786]: info: Refreshing Cached IP Addresses Mar 03 12:05:33 volumio sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 12:05:33 volumio sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:33 volumio sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 12:05:33 volumio sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:33 volumio sudo[893]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:33 volumio volumio[786]: info: Loading plugin "services"... Mar 03 12:05:33 volumio volumio[786]: info: Loading plugin "alsa_controller"... Mar 03 12:05:33 volumio sudo[895]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:33 volumio sudo[905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 03 12:05:33 volumio sudo[905]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:33 volumio sudo[905]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:33 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 12:05:33 volumio volumio[786]: info: Loading plugin "wizard"... Mar 03 12:05:33 volumio volumio[786]: info: Loading plugin "networkfs"... Mar 03 12:05:33 volumio volumio[786]: info: Starting Udev Watcher for removable devices Mar 03 12:05:34 volumio sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.100.101:/volume1/fisiere NAS/muzica /mnt/NAS/NAS Mar 03 12:05:34 volumio sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:34 volumio volumio[786]: info: Ignoring mount for partition: boot Mar 03 12:05:34 volumio volumio[786]: info: Ignoring mount for partition: volumio Mar 03 12:05:34 volumio volumio[786]: info: Ignoring mount for partition: volumio_data Mar 03 12:05:34 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 12:05:34 volumio volumio[786]: info: Loading plugin "volumio_command_line_client"... Mar 03 12:05:34 volumio volumio[786]: info: Loading plugin "upnp"... Mar 03 12:05:34 volumio volumio[786]: info: [1740996334045] Starting Upmpd Daemon Mar 03 12:05:34 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 12:05:34 volumio volumio[786]: info: Loading plugin "my_music"... Mar 03 12:05:34 volumio volumio[786]: info: Loading plugin "mpd"... Mar 03 12:05:34 volumio volumio[786]: info: Loading plugin "upnp_browser"... Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "alarm-clock"... Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "airplay_emulation"... Mar 03 12:05:35 volumio volumio[786]: info: Starting Shairport Sync Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "last_100"... Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "webradio"... Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "i2s_dacs"... Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "volumiodiscovery"... Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** For more information see Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 03 12:05:35 volumio node[786]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 12:05:35 volumio volumio[786]: *** WARNING *** For more information see Mar 03 12:05:35 volumio node[786]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 12:05:35 volumio node[786]: *** WARNING *** For more information see Mar 03 12:05:35 volumio node[786]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 03 12:05:35 volumio node[786]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 12:05:35 volumio node[786]: *** WARNING *** For more information see Mar 03 12:05:35 volumio volumio[786]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 03 12:05:35 volumio volumio[786]: info: Discovery: Started advertising with name: Volumio Mar 03 12:05:35 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 12:05:35 volumio volumio[786]: info: Plugin youtube2 is not enabled Mar 03 12:05:35 volumio volumio[786]: info: Loading plugin "ytmusic"... Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "outputs"... Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "albumart"... Mar 03 12:05:40 volumio volumio[786]: info: Plugin example_plugin is not enabled Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "inputs"... Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "updater_comm"... Mar 03 12:05:40 volumio volumio[786]: info: Plugin mpdemulation is not enabled Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "rest_api"... Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "websocket"... Mar 03 12:05:40 volumio volumio[786]: info: Starting Socket.io Server version 2.3.0 Mar 03 12:05:40 volumio volumio[786]: info: Loading plugin "80s80s"... Mar 03 12:05:40 volumio volumio[786]: Forking 3 albumart workers Mar 03 12:05:41 volumio volumio[786]: info: Applying required configuration parameters for plugin 80s80s Mar 03 12:05:41 volumio volumio[786]: info: [1740996341066] [80s80s] API delay: 30 Mar 03 12:05:41 volumio volumio[786]: info: Loading plugin "radio_paradise"... Mar 03 12:05:41 volumio volumio[786]: Starting albumart workers Mar 03 12:05:41 volumio volumio[786]: info: Applying required configuration parameters for plugin radio_paradise Mar 03 12:05:41 volumio volumio[786]: info: [1740996341602] [RadioParadise] API delay: 5 Mar 03 12:05:41 volumio volumio[786]: info: Loading plugin "Systeminfo"... Mar 03 12:05:41 volumio volumio[786]: Starting albumart workers Mar 03 12:05:41 volumio volumio[786]: Starting albumart workers Mar 03 12:05:42 volumio volumio[786]: info: Loading i18n strings for locale en Mar 03 12:05:42 volumio volumio[786]: Updating browse sources language Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::initPlayerControls Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 12:05:42 volumio volumio[786]: Express server listening on port 3000 Mar 03 12:05:42 volumio volumio[786]: [Metrics] WebUI: 16s 571.72ms Mar 03 12:05:42 volumio volumio[786]: info: CoreStateMachine::resetVolumioState Mar 03 12:05:42 volumio volumio[786]: info: CoreStateMachine::getcurrentVolume Mar 03 12:05:42 volumio volumio[786]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 12:05:42 volumio volumio[786]: info: Volumio Network Manager: Network status updated: 1 Mar 03 12:05:42 volumio volumio[786]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 03 12:05:42 volumio volumio[786]: wlan0 Interface doesn't support scanning. Mar 03 12:05:42 volumio volumio[786]: info: Cannot use regular scanning, forcing with ap-force Mar 03 12:05:42 volumio sudo[993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 03 12:05:42 volumio sudo[993]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:42 volumio sudo[993]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:42 volumio volumio[786]: command failed: No such device (-19) Mar 03 12:05:42 volumio volumio[786]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 03 12:05:42 volumio volumio[786]: command failed: No such device (-19) Mar 03 12:05:43 volumio volumio[786]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 03 12:05:43 volumio volumio[786]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Mar 03 12:05:43 volumio volumio[786]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Mar 03 12:05:43 volumio volumio[786]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 12:05:43 volumio volumio[786]: info: Executing start script for DAC IQaudIO DAC Plus Mar 03 12:05:43 volumio volumio[786]: info: Reloading queue from file Mar 03 12:05:43 volumio volumio[786]: info: VolumeController:: Volume=33 Mute =false Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::updateTrackBlock Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrackBlock Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 12:05:43 volumio volumio[786]: info: Setting Device type: Raspberry PI Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::setRepeat false single undefined Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::setRandom true Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:43 volumio volumio[786]: info: DAC script executed Mar 03 12:05:43 volumio volumio[786]: info: VolumeController:: Volume=33 Mute =false Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:43 volumio volumio[786]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.102 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 12:05:43 volumio volumio[786]: info: Received Get System Info Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 12:05:43 volumio volumio[786]: info: Discovery: Getting this device information Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:43 volumio volumio[786]: info: Listing playlists Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetQueue Mar 03 12:05:43 volumio volumio[786]: info: CoreStateMachine::getQueue Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getQueue Mar 03 12:05:43 volumio volumio[786]: info: Discovery: adding ad2acd9f-243e-40e5-86ab-9970788ba54b Mar 03 12:05:43 volumio volumio[786]: info: Discovery: Found device Volumio Mar 03 12:05:43 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Mar 03 12:05:43 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:44 volumio sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 12:05:44 volumio sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:44 volumio sudo[1024]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:44 volumio sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 12:05:44 volumio sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:44 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:44 volumio sudo[1032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 03 12:05:44 volumio sudo[1032]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 12:05:44 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 03 12:05:44 volumio sudo[1032]: pam_unix(sudo:session): session closed for user root Mar 03 12:05:44 volumio volumio[786]: info: Upmpdcli Daemon Started Mar 03 12:05:44 volumio volumio[1034]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 03 12:05:46 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 03 12:05:47 volumio volumio-remote-updater[556]: [2025-03-03 12:05:47] [connect] Successful connection Mar 03 12:05:47 volumio volumio-remote-updater[556]: [2025-03-03 12:05:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740996347 101 Mar 03 12:05:47 volumio volumio[786]: 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: 6 Mar 03 12:05:49 volumio volumio[1034]: ......................................++++ Mar 03 12:05:51 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 03 12:05:53 volumio volumio[786]: info: VolumeController::SetAlsaVolume71 Mar 03 12:05:53 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:53 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:53 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 12:05:53 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:54 volumio volumio[786]: info: VolumeController::SetAlsaVolume91 Mar 03 12:05:54 volumio volumio[786]: info: CoreStateMachine::pushState Mar 03 12:05:54 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Mar 03 12:05:54 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 12:05:54 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Mar 03 12:05:58 volumio volumio[1034]: ..................................................................++++ Mar 03 12:05:58 volumio volumio[1034]: e is 65537 (0x010001) Mar 03 12:05:58 volumio volumio[1034]: writing RSA key Mar 03 12:05:59 volumio volumio[786]: info: Preload queue cleared Mar 03 12:05:59 volumio volumio[786]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 03 12:05:59 volumio volumio[786]: info: CoreStateMachine::ClearQueue Mar 03 12:05:59 volumio volumio[786]: info: CoreStateMachine::stop Mar 03 12:05:59 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 12:05:59 volumio volumio[786]: info: CorePlayQueue::clearPlayQueue Mar 03 12:05:59 volumio volumio[786]: info: CorePlayQueue::saveQueue Mar 03 12:05:59 volumio volumio[786]: info: CoreCommandRouter::volumioPushQueue Mar 03 12:05:59 volumio volumio[786]: info: CoreStateMachine::addQueueItems Mar 03 12:05:59 volumio volumio[786]: info: CorePlayQueue::addQueueItems Mar 03 12:05:59 volumio volumio[786]: info: Preload queue cleared Mar 03 12:05:59 volumio volumio[786]: info: Adding Item to queue: webnineties/0 Mar 03 12:05:59 volumio volumio[786]: info: Exploding uri webnineties/0 in service 80s80s Mar 03 12:05:59 volumio volumio[786]: info: [1740996359529] [80s80s] explodeUri: webnineties/0 Mar 03 12:05:59 volumio volumio[786]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 12:05:59 volumio volumio[786]: TypeError: Cannot read property 'PLUGIN_NAME' of undefined Mar 03 12:05:59 volumio volumio[786]: at Controller80s80s.getRadioI18nString (/data/plugins/music_service/80s80s/index.js:518:25) Mar 03 12:05:59 volumio volumio[786]: at Controller80s80s.explodeUri (/data/plugins/music_service/80s80s/index.js:411:33) Mar 03 12:05:59 volumio volumio[786]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1378:16) Mar 03 12:05:59 volumio volumio[786]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Mar 03 12:05:59 volumio volumio[786]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Mar 03 12:05:59 volumio volumio[786]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Mar 03 12:05:59 volumio volumio[786]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Mar 03 12:05:59 volumio volumio[786]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:526:23) Mar 03 12:05:59 volumio volumio[786]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Mar 03 12:05:59 volumio volumio[786]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Mar 03 12:05:59 volumio volumio[786]: at Socket.emit (events.js:315:20) Mar 03 12:05:59 volumio volumio[786]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 03 12:05:59 volumio volumio[786]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 03 12:05:59 volumio volumio[786]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 12:06:00 volumio sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 12:05 Mar 03 12:06:00 volumio sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"