Nov 03 20:24:29 volumio ntpd[935]: CLOCK: time stepped by 13533300.255274 Nov 03 20:24:29 volumio ntpd[935]: CLOCK: time changed from 2025-05-31 to 2025-11-03 Nov 03 20:24:29 volumio ntpd[935]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Nov 03 20:24:29 volumio volumio[1073]: info: Volumio Network Manager: Network status updated: 1 Nov 03 20:24:29 volumio volumio[1387]: Forking 3 albumart workers Nov 03 20:24:29 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:24:29 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:29 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:29 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:24:29 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:29 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Nov 03 20:24:29 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Nov 03 20:24:29 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 20:24:29 volumio volumio[1073]: info: Setting Device type: Raspberry PI Nov 03 20:24:30 volumio volumio[1073]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 03 20:24:30 volumio volumio[1073]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Nov 03 20:24:30 volumio volumio[1073]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 03 20:24:30 volumio sudo[1340]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:30 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 03 20:24:30 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:24:30 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:30 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: adding b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:30 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: Device volumio disappeared from network Nov 03 20:24:30 volumio volumio-remote-updater[709]: [2025-11-03 19:24:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1748664565 101 Nov 03 20:24:30 volumio volumio[1073]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 03 20:24:30 volumio volumio[1073]: info: CoreStateMachine::getcurrentVolume Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: adding b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:30 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: this is already registered, b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:30 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:30 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:30 volumio volumio[1073]: info: Discovery: Device volumio disappeared from network Nov 03 20:24:31 volumio volumio[1073]: info: Completed loading Core Plugins Nov 03 20:24:31 volumio volumio[1073]: info: Preparing to generate the ALSA configuration file Nov 03 20:24:31 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:24:31 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:31 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:31 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:31 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Nov 03 20:24:31 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Nov 03 20:24:31 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 20:24:31 volumio firststart.sh[1218]: Creating SSH2 RSA key; this may take some time ... Nov 03 20:24:31 volumio firststart.sh[1473]: 3072 SHA256:gW3hpug8tDJfzxsTEaZpiQuLHqsDQ2eTltwSRjHF4Cs root@volumio (RSA) Nov 03 20:24:31 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:24:31 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:31 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:31 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:31 volumio volumio[1073]: info: Asound.conf file written Nov 03 20:24:31 volumio sudo[1480]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 20:24:31 volumio sudo[1480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:31 volumio sudo[1480]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:31 volumio firststart.sh[1218]: Creating SSH2 DSA key; this may take some time ... Nov 03 20:24:32 volumio firststart.sh[1485]: 1024 SHA256:E11TPrhxF5rxHUOIUF4G1cKOqgtOtn4aASswM+vcT4g root@volumio (DSA) Nov 03 20:24:32 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Nov 03 20:24:32 volumio volumio[1073]: No state is present for card b1 Nov 03 20:24:32 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Nov 03 20:24:32 volumio volumio[1073]: /usr/share/alsa/init/bcm2835:14: control element not found Nov 03 20:24:32 volumio volumio[1073]: No state is present for card b1 Nov 03 20:24:32 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Nov 03 20:24:32 volumio volumio[1073]: No state is present for card Headphones Nov 03 20:24:32 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Nov 03 20:24:32 volumio volumio[1073]: /usr/share/alsa/init/bcm2835:20: control element not found Nov 03 20:24:32 volumio volumio[1073]: No state is present for card Headphones Nov 03 20:24:32 volumio volumio[1073]: info: Output device has changed, restarting MPD Nov 03 20:24:32 volumio dhcpcd[794]: wlan0: using IPv4LL address 169.254.49.246 Nov 03 20:24:32 volumio avahi-daemon[695]: Registering new address record for 169.254.49.246 on wlan0.IPv4. Nov 03 20:24:32 volumio dhcpcd[794]: wlan0: adding route to 169.254.0.0/16 Nov 03 20:24:32 volumio firststart.sh[1218]: Creating SSH2 ECDSA key; this may take some time ... Nov 03 20:24:32 volumio firststart.sh[1493]: 256 SHA256:476Z8qKVfoKL/vx1Tw2Qmnjr7JmDEjcQUo7/+VTJoXg root@volumio (ECDSA) Nov 03 20:24:32 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Nov 03 20:24:32 volumio volumio[1073]: info: Output device has changed, restarting Shairport Sync Nov 03 20:24:32 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:32 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:32 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Nov 03 20:24:32 volumio systemd[1]: welcome.service: Deactivated successfully. Nov 03 20:24:32 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 03 20:24:32 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 03 20:24:32 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 03 20:24:32 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Nov 03 20:24:32 volumio welcome[1533]: Resolved ip:[3] 192.168.1.49 192.168.211.1 169.254.49.246 Nov 03 20:24:32 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 03 20:24:32 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:32 volumio sudo[1517]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 20:24:32 volumio sudo[1517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:32 volumio sudo[1520]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 20:24:32 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:32 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 20:24:32 volumio volumio[1073]: info: ___________ START PLUGINS ___________ Nov 03 20:24:32 volumio firststart.sh[1548]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Nov 03 20:24:32 volumio firststart.sh[1548]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty). Nov 03 20:24:32 volumio firststart.sh[1548]: insserv: Script `ssh' has overlapping Default-Start and Default-Stop runlevels (2 3 4 5) and (2 3 4 5). This should be fixed. Nov 03 20:24:32 volumio firststart.sh[1548]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Nov 03 20:24:32 volumio sudo[1517]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:32 volumio volumio[1073]: info: Setting Hotspot Unique name on first start: Volumio-522D2 Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Nov 03 20:24:32 volumio volumio[1073]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::Reload Ui Nov 03 20:24:32 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Nov 03 20:24:32 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Nov 03 20:24:32 volumio systemd[1]: Reloading. Nov 03 20:24:32 volumio volumio[1073]: info: ControllerMpd::onStart: Initializing MPD Nov 03 20:24:32 volumio volumio[1073]: info: Creating MPD Configuration file Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 20:24:32 volumio volumio[1073]: info: [1762197872665] CoreMusicLibrary::Adding element Media Servers Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:32 volumio sudo[1594]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 20:24:32 volumio sudo[1594]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:32 volumio sudo[1594]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:32 volumio sudo[1612]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 20:24:32 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:32 volumio volumio[1403]: Starting albumart workers Nov 03 20:24:32 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:33 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 20:24:33 volumio volumio[1073]: info: [1762197873022] CoreMusicLibrary::Adding element Last_100 Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 20:24:33 volumio volumio[1073]: info: [1762197873037] CoreMusicLibrary::Adding element Webradio Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 20:24:33 volumio volumio[1073]: info: Initializing BBC Radios Nov 03 20:24:33 volumio ntpd[935]: IO: Listen normally on 5 wlan0 169.254.49.246:123 Nov 03 20:24:33 volumio ntpd[935]: IO: new interface(s) found: waking up resolver Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 20:24:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:33 volumio volumio[1073]: info: Volumio Calling Home Nov 03 20:24:33 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Nov 03 20:24:33 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Nov 03 20:24:33 volumio sudo[1642]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 20:24:33 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:24:33 volumio sudo[1646]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 03 20:24:33 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:33 volumio volumio[1405]: Starting albumart workers Nov 03 20:24:33 volumio volumio[1404]: Starting albumart workers Nov 03 20:24:34 volumio systemd[1]: Reloading. Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: adding b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:35 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: this is already registered, b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:35 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:35 volumio sudo[1681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Nov 03 20:24:35 volumio sudo[1681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:35 volumio sudo[1681]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:35 volumio volumio[1073]: info: MPD Permissions set Nov 03 20:24:35 volumio volumio[1073]: info: MPD Permissions set Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: this is already registered, b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:35 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:35 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:35 volumio firststart.sh[1691]: rescue-ssh.target is a disabled or a static unit not running, not starting it. Nov 03 20:24:35 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 03 20:24:35 volumio volumio[1073]: info: Permissions for /etc/hostapd/hostapd.conf Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Nov 03 20:24:36 volumio volumio[1073]: info: Discovery: Restarting Advertising due to device name change Nov 03 20:24:36 volumio firststart.sh[1691]: ssh.service is a disabled or a static unit not running, not starting it. Nov 03 20:24:36 volumio volumio[1073]: info: Volumio called home Nov 03 20:24:36 volumio sudo[1699]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Nov 03 20:24:36 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:36 volumio systemd[1]: Starting wireless.service - Wireless Services... Nov 03 20:24:36 volumio systemd[1]: Reloading. Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:36 volumio sudo[1731]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:24:37 volumio sudo[1731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:37 volumio sudo[1731]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:37 volumio sudo[1733]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:24:37 volumio sudo[1733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:37 volumio sudo[1733]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:24:38 volumio volumio[1073]: info: Starting Shairport Sync Nov 03 20:24:38 volumio volumio[1073]: info: Starting Shairport Sync Nov 03 20:24:38 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Nov 03 20:24:38 volumio volumio[1073]: info: Starting Shairport Sync Nov 03 20:24:38 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Nov 03 20:24:38 volumio dnsmasq[1100]: exiting on receipt of SIGTERM Nov 03 20:24:38 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Nov 03 20:24:38 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Nov 03 20:24:38 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Nov 03 20:24:38 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Nov 03 20:24:38 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Nov 03 20:24:38 volumio sudo[1777]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 20:24:38 volumio sudo[1777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:38 volumio firststart.sh[1772]: ssh.socket is a disabled or a static unit not running, not starting it. Nov 03 20:24:38 volumio sudo[1782]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 20:24:38 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:38 volumio sudo[1779]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 20:24:38 volumio sudo[1779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:38 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Nov 03 20:24:38 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Nov 03 20:24:38 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:24:38 volumio systemd[1]: shairport-sync.service: Consumed 1.877s CPU time. Nov 03 20:24:38 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:24:38 volumio sudo[1777]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:38 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Nov 03 20:24:38 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Nov 03 20:24:38 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:24:38 volumio firststart.sh[1074]: Enabling SSH for first boot Nov 03 20:24:38 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:24:38 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:38 volumio systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Nov 03 20:24:38 volumio sudo[1779]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:38 volumio volumio[1073]: info: Shairport-Sync Started Nov 03 20:24:38 volumio volumio[1073]: Error adding Membership: Error: addMembership EINVAL Nov 03 20:24:38 volumio volumio[1073]: info: Shairport-Sync Started Nov 03 20:24:38 volumio volumio[1073]: info: Shairport-Sync Started Nov 03 20:24:38 volumio dhcpcd[794]: wlan0: carrier lost Nov 03 20:24:38 volumio systemd[1]: hostapd.service: Deactivated successfully. Nov 03 20:24:38 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Nov 03 20:24:38 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 03 20:24:39 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:39 volumio volumio[1073]: info: Discovery: Device volumio disappeared from network Nov 03 20:24:39 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:39 volumio volumio[1073]: info: Discovery: A device disappeared from network Nov 03 20:24:39 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:39 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:39 volumio sudo[1825]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Nov 03 20:24:39 volumio sudo[1825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:24:39 volumio avahi-daemon[695]: Withdrawing address record for 169.254.49.246 on wlan0. Nov 03 20:24:39 volumio dhcpcd[794]: wlan0: deleting route to 169.254.0.0/16 Nov 03 20:24:39 volumio sudo[1824]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 03 20:24:39 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:39 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:39 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Nov 03 20:24:39 volumio systemd[1]: welcome.service: Deactivated successfully. Nov 03 20:24:39 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 03 20:24:39 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 03 20:24:39 volumio avahi-daemon[695]: Withdrawing address record for 192.168.211.1 on wlan0. Nov 03 20:24:39 volumio avahi-daemon[695]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Nov 03 20:24:39 volumio avahi-daemon[695]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 03 20:24:39 volumio sudo[1825]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:39 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 03 20:24:39 volumio welcome[1849]: Resolved ip:[1] 192.168.1.49 Nov 03 20:24:39 volumio sudo[1869]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Nov 03 20:24:39 volumio sudo[1869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:24:39 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 03 20:24:39 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:39 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:39 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Nov 03 20:24:39 volumio systemd[1]: welcome.service: Deactivated successfully. Nov 03 20:24:39 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 03 20:24:39 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 03 20:24:39 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 03 20:24:39 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Nov 03 20:24:39 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:39 volumio volumio[1073]: info: Upmpdcli Daemon Started Nov 03 20:24:40 volumio mpd[1648]: 2025-11-03T19:24:40 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 20:24:40 volumio mpd[1648]: 2025-11-03T19:24:40 exception: Database corrupted Nov 03 20:24:40 volumio systemd[1]: Started mpd.service - Music Player Daemon. Nov 03 20:24:40 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio sudo[1520]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio sudo[1869]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio welcome[1885]: Resolved ip:[1] 192.168.1.49 Nov 03 20:24:40 volumio sshd[1880]: Server listening on 0.0.0.0 port 22. Nov 03 20:24:40 volumio sshd[1880]: Server listening on :: port 22. Nov 03 20:24:40 volumio systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Nov 03 20:24:40 volumio firststart.sh[1074]: Disabling firststart service Nov 03 20:24:40 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 03 20:24:40 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:40 volumio volumio[1073]: info: Completed starting Core Plugins Nov 03 20:24:40 volumio volumio[1073]: info: ------------------------------------------- Nov 03 20:24:40 volumio volumio[1073]: info: ----- MyVolumio plugins startup ---- Nov 03 20:24:40 volumio volumio[1073]: info: ------------------------------------------- Nov 03 20:24:40 volumio volumio[1073]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 03 20:24:40 volumio systemctl[1908]: Removed "/etc/systemd/system/multi-user.target.wants/firststart.service". Nov 03 20:24:40 volumio systemd[1]: Reloading. Nov 03 20:24:40 volumio sudo[1915]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 03 20:24:40 volumio sudo[1915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:40 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 03 20:24:40 volumio sudo[1915]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio sudo[1928]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Nov 03 20:24:40 volumio sudo[1928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:40 volumio sudo[1928]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio volumio[1073]: error: MPD error: The expression evaluated to a falsy value: Nov 03 20:24:40 volumio volumio[1073]: assert.ok(self.idling) Nov 03 20:24:40 volumio volumio[1073]: error: The expression evaluated to a falsy value: Nov 03 20:24:40 volumio volumio[1073]: assert.ok(self.idling) Nov 03 20:24:40 volumio sudo[1941]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 03 20:24:40 volumio sudo[1941]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:40 volumio sudo[1941]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:40 volumio sudo[1943]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Nov 03 20:24:40 volumio sudo[1943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:40 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:24:40 volumio volumio[1073]: info: Nov 03 20:24:40 volumio volumio[1073]: ---------------------------- MPD announces state update: update Nov 03 20:24:40 volumio volumio[1073]: info: ControllerMpd::getState Nov 03 20:24:40 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:24:40 volumio volumio[1073]: info: MPD running with PID1648 Nov 03 20:24:40 volumio volumio[1073]: ,establishing connection Nov 03 20:24:40 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:24:40 volumio volumio[1073]: info: Nov 03 20:24:40 volumio volumio[1073]: ---------------------------- MPD announces state update: update Nov 03 20:24:40 volumio volumio[1073]: error: updateQueue error: null Nov 03 20:24:40 volumio volumio[1073]: info: ControllerMpd::getState Nov 03 20:24:41 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:24:41 volumio volumio[1073]: info: sendMpdCommand status took 56 milliseconds Nov 03 20:24:41 volumio volumio[1073]: info: sendMpdCommand status took 66 milliseconds Nov 03 20:24:41 volumio volumio[1073]: verbose: ControllerMpd::parseState Nov 03 20:24:41 volumio volumio[1073]: info: Command Router : Notfying DB Updatefalse Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Nov 03 20:24:41 volumio volumio[1073]: verbose: ControllerMpd::parseState Nov 03 20:24:41 volumio volumio[1073]: info: ControllerMpd::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 03 20:24:41 volumio volumio[1073]: verbose: CURRENT POSITION 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: No code Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: ------------------------------ 377ms Nov 03 20:24:41 volumio volumio[1073]: info: Discovery: Started advertising with name: Volumio Nov 03 20:24:41 volumio firststart.sh[1074]: Finalizing Nov 03 20:24:41 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Nov 03 20:24:41 volumio systemd[1]: firststart.service: Deactivated successfully. Nov 03 20:24:41 volumio systemd[1]: firststart.service: Consumed 11.707s CPU time. Nov 03 20:24:41 volumio volumio[1073]: error: updateQueue error: null Nov 03 20:24:41 volumio volumio[1073]: info: sendMpdCommand status took 540 milliseconds Nov 03 20:24:41 volumio volumio[1073]: info: sendMpdCommand status took 523 milliseconds Nov 03 20:24:41 volumio volumio[1073]: verbose: ControllerMpd::parseState Nov 03 20:24:41 volumio volumio[1073]: info: Command Router : Notfying DB Updatefalse Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Nov 03 20:24:41 volumio volumio[1073]: verbose: ControllerMpd::parseState Nov 03 20:24:41 volumio volumio[1073]: info: ControllerMpd::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 03 20:24:41 volumio volumio[1073]: verbose: CURRENT POSITION 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: No code Nov 03 20:24:41 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:24:41 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:24:41 volumio volumio[1073]: info: ------------------------------ 688ms Nov 03 20:24:42 volumio ntpd[935]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=19 secs Nov 03 20:24:42 volumio ntpd[935]: IO: Deleting interface #5 wlan0, 169.254.49.246#123, interface stats: received=0, sent=0, dropped=0, active_time=9 secs Nov 03 20:24:42 volumio volumio[1073]: info: Discovery: adding b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:42 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:42 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:42 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:42 volumio volumio[1073]: info: Discovery: this is already registered, b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:42 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:42 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:42 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:43 volumio sudo[1967]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:24:43 volumio sudo[1967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:43 volumio sudo[1965]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:24:43 volumio sudo[1965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:43 volumio sudo[1967]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio sudo[1965]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 03 20:24:43 volumio sudo[1943]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Nov 03 20:24:43 volumio sudo[1975]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 03 20:24:43 volumio sudo[1975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:43 volumio sudo[1975]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio sudo[1979]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Nov 03 20:24:43 volumio sudo[1979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:43 volumio sudo[1979]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio sudo[1986]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Nov 03 20:24:43 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 03 20:24:43 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:43 volumio sudo[1988]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Nov 03 20:24:43 volumio sudo[1988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 03 20:24:43 volumio volumio[1073]: info: Received Get System Info Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:24:43 volumio volumio[1073]: info: Discovery: Getting this device information Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:43 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:24:43 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Nov 03 20:24:43 volumio volumio-remote-updater[709]: Test mode disabled Nov 03 20:24:43 volumio volumio-remote-updater[709]: Alpha mode disabled Nov 03 20:24:43 volumio volumio-remote-updater[709]: Alpha legacy test mode disabled Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 20:24:43 volumio volumio[1073]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 20:24:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 20:24:44 volumio sudo[1988]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:44 volumio avahi-daemon[695]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Nov 03 20:24:44 volumio avahi-daemon[695]: New relevant interface wlan0.IPv4 for mDNS. Nov 03 20:24:44 volumio avahi-daemon[695]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Nov 03 20:24:44 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 03 20:24:44 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:44 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Nov 03 20:24:44 volumio systemd[1]: welcome.service: Deactivated successfully. Nov 03 20:24:44 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 03 20:24:44 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 03 20:24:44 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 03 20:24:44 volumio welcome[1999]: Resolved ip:[2] 192.168.1.49 192.168.211.1 Nov 03 20:24:44 volumio systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Nov 03 20:24:44 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 03 20:24:44 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:44 volumio dhcpcd[794]: wlan0: carrier acquired Nov 03 20:24:44 volumio hostapd[2002]: wlan0: interface state UNINITIALIZED->ENABLED Nov 03 20:24:44 volumio hostapd[2002]: wlan0: AP-ENABLED Nov 03 20:24:44 volumio systemd[1]: hostapd.service: Can't open PID file /run/hostapd.pid (yet?) after start: No such file or directory Nov 03 20:24:44 volumio systemd[1]: Started hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Nov 03 20:24:44 volumio dhcpcd[794]: wlan0: IAID dd:95:aa:b1 Nov 03 20:24:44 volumio systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Nov 03 20:24:44 volumio iwconfig[2011]: Error for wireless request "Set Power Management" (8B2C) : Nov 03 20:24:44 volumio iwconfig[2011]: SET failed on device wlan0 ; Invalid argument. Nov 03 20:24:44 volumio systemd[1]: wireless.service: Deactivated successfully. Nov 03 20:24:44 volumio systemd[1]: Started wireless.service - Wireless Services. Nov 03 20:24:44 volumio systemd[1]: wireless.service: Consumed 10.827s CPU time. Nov 03 20:24:44 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:44 volumio dnsmasq[2014]: started, version 2.90 cachesize 150 Nov 03 20:24:44 volumio dnsmasq[2014]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Nov 03 20:24:44 volumio dnsmasq-dhcp[2014]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Nov 03 20:24:44 volumio dnsmasq[2014]: reading /etc/resolv.conf Nov 03 20:24:44 volumio dnsmasq[2014]: using nameserver 192.168.1.1#53 Nov 03 20:24:44 volumio dnsmasq[2014]: using nameserver 208.67.222.222#53 Nov 03 20:24:44 volumio dnsmasq[2014]: using nameserver 208.67.220.220#53 Nov 03 20:24:44 volumio dnsmasq[2014]: read /etc/hosts - 16 names Nov 03 20:24:44 volumio systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Nov 03 20:24:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 03 20:24:45 volumio volumio[1073]: info: Loading i18n strings for locale pl Nov 03 20:24:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 03 20:24:45 volumio volumio[1073]: info: Setting timezone to Europe/Warsaw Nov 03 20:24:45 volumio sudo[2019]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 03 20:24:45 volumio sudo[2019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:45 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:45 volumio sudo[2023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Nov 03 20:24:45 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:45 volumio dhcpcd[794]: wlan0: soliciting an IPv6 router Nov 03 20:24:45 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:45 volumio sudo[2027]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 03 20:24:45 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:45 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:45 volumio sudo[2031]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Nov 03 20:24:45 volumio sudo[2031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:45 volumio dbus-daemon[697]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.29' (uid=0 pid=2032 comm="/usr/bin/timedatectl set-timezone Europe/Warsaw") Nov 03 20:24:45 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Nov 03 20:24:46 volumio dhcpcd[794]: wlan0: soliciting a DHCP lease Nov 03 20:24:46 volumio dbus-daemon[697]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 03 20:24:46 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Nov 03 20:24:46 volumio sudo[2031]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 20:24:46 volumio ntpd[935]: IO: Listen normally on 6 wlan0 192.168.211.1:123 Nov 03 20:24:46 volumio ntpd[935]: IO: new interface(s) found: waking up resolver Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 20:24:46 volumio volumio[1073]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 03 20:24:46 volumio volumio[1073]: info: Discovery: this is already registered, b52143ff-2de1-41e5-9d1b-87f4a9b76f96 Nov 03 20:24:46 volumio volumio[1073]: info: Discovery: Found device Volumio Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:24:46 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:24:46 volumio volumio[1073]: Updating browse sources language Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 03 20:24:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin bluetooth to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin multiroom to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin metavolumio to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin cd_controller to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 03 20:24:48 volumio volumio[1073]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 03 20:24:51 volumio volumio[1073]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 03 20:24:51 volumio volumio[1073]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 03 20:24:51 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:51 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:24:51 volumio dhcpcd[794]: wlan0: probing for an IPv4LL address Nov 03 20:24:51 volumio volumio[1073]: info: Starting MyVolumio Remote Streaming Endpoints Nov 03 20:24:51 volumio volumio[1073]: info: MyVolumio not started Nov 03 20:24:51 volumio volumio[1073]: info: Initializing device activation check Nov 03 20:24:51 volumio volumio[1073]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 03 20:24:51 volumio volumio[1073]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 03 20:24:52 volumio volumio[1073]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 03 20:24:52 volumio volumio[1073]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 03 20:24:52 volumio volumio[1073]: info: Streaming services startup Nov 03 20:24:52 volumio volumio[1073]: info: Starting Streaming Daemon Nov 03 20:24:52 volumio sudo[2053]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 20:24:52 volumio sudo[2053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:52 volumio sudo[2053]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:52 volumio volumio[1073]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 03 20:24:52 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Nov 03 20:24:52 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Nov 03 20:24:52 volumio volumio[1073]: error: Cannot start Volumio Streaming Daemon Nov 03 20:24:52 volumio sudo[2059]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:24:52 volumio volumio[1073]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 20:24:52 volumio volumio[1073]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 20:24:52 volumio sudo[2059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:52 volumio sudo[2059]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:54 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Nov 03 20:24:54 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Nov 03 20:24:54 volumio volumio[1073]: info: Refreshing Cached IP Addresses Nov 03 20:24:54 volumio upmpdcli[2061]: writing RSA key Nov 03 20:24:54 volumio sudo[2063]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Nov 03 20:24:54 volumio sudo[2063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:54 volumio sudo[2063]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:54 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Nov 03 20:24:54 volumio systemd[1]: upmpdcli.service: Consumed 12.750s CPU time. Nov 03 20:24:54 volumio sudo[2065]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:24:54 volumio sudo[2065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:54 volumio sudo[2071]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:24:54 volumio sudo[2071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:54 volumio sudo[2065]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:54 volumio sudo[2071]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:55 volumio dhcpcd[794]: wlan0: using IPv4LL address 169.254.49.246 Nov 03 20:24:55 volumio avahi-daemon[695]: Registering new address record for 169.254.49.246 on wlan0.IPv4. Nov 03 20:24:55 volumio dhcpcd[794]: wlan0: adding route to 169.254.0.0/16 Nov 03 20:24:55 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:55 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Nov 03 20:24:55 volumio systemd[1]: welcome.service: Deactivated successfully. Nov 03 20:24:55 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 03 20:24:55 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 03 20:24:56 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 03 20:24:56 volumio welcome[2081]: Resolved ip:[3] 192.168.1.49 192.168.211.1 169.254.49.246 Nov 03 20:24:56 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 03 20:24:56 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Nov 03 20:24:57 volumio ntpd[935]: IO: Listen normally on 7 wlan0 169.254.49.246:123 Nov 03 20:24:57 volumio ntpd[935]: IO: new interface(s) found: waking up resolver Nov 03 20:24:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 03 20:24:59 volumio volumio[1073]: info: Loading i18n strings for locale pl Nov 03 20:24:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 03 20:24:59 volumio volumio[1073]: info: Setting timezone to Europe/Warsaw Nov 03 20:24:59 volumio sudo[2112]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 03 20:24:59 volumio sudo[2112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:59 volumio sudo[2112]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:59 volumio sudo[2116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Nov 03 20:24:59 volumio sudo[2116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:59 volumio sudo[2116]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:59 volumio sudo[2120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 03 20:24:59 volumio sudo[2120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:59 volumio sudo[2120]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:59 volumio sudo[2124]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Nov 03 20:24:59 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:59 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root Nov 03 20:24:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 03 20:24:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 03 20:24:59 volumio sudo[2127]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 20:24:59 volumio sudo[2127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:24:59 volumio volumio[1073]: Updating browse sources language Nov 03 20:24:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:24:59 volumio volumio[1073]: info: Fetching Streaming Services browse cache Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 20:25:01 volumio volumio[1073]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 03 20:25:01 volumio volumio[1073]: info: Received Get System Version Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 20:25:01 volumio volumio[1073]: info: Received Get System Info Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:25:01 volumio volumio[1073]: info: Discovery: Getting this device information Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:01 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:25:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Nov 03 20:25:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Nov 03 20:25:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 03 20:25:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 20:25:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 20:25:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 20:25:03 volumio volumio-remote-updater[709]: Test mode disabled Nov 03 20:25:03 volumio volumio-remote-updater[709]: Alpha mode disabled Nov 03 20:25:03 volumio volumio-remote-updater[709]: Alpha legacy test mode disabled Nov 03 20:25:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 20:25:03 volumio sudo[2127]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:03 volumio volumio[1073]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 20:25:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 20:25:04 volumio sudo[2139]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:25:04 volumio sudo[2139]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:04 volumio sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:25:04 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:04 volumio sudo[2139]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:04 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:04 volumio sudo[2144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 03 20:25:04 volumio sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:05 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Nov 03 20:25:05 volumio sudo[2144]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:05 volumio volumio[1073]: info: Upmpdcli Daemon Started Nov 03 20:25:05 volumio upmpdcli[2161]: writing RSA key Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 20:25:06 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 03 20:25:06 volumio volumio[1073]: info: Preparing to save Alsa Options, stopping services first Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPause Nov 03 20:25:06 volumio volumio[1073]: info: CoreStateMachine::pause Nov 03 20:25:06 volumio volumio[1073]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"1","label":"Headphones"},"disallowPush":true} Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 20:25:06 volumio volumio[1073]: info: Found match in Cards Database: setting mixer PCM for card Headphones Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 03 20:25:06 volumio volumio[1073]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 03 20:25:06 volumio volumio[1073]: info: Disabling external Volume Control Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:06 volumio volumio[1073]: info: Preparing to generate the ALSA configuration file Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 03 20:25:06 volumio sudo[2178]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 20:25:06 volumio sudo[2178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:06 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:25:06 volumio sudo[2180]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 20:25:06 volumio sudo[2180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:06 volumio sudo[2180]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:06 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:25:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 03 20:25:07 volumio volumio[1073]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 03 20:25:07 volumio volumio[1073]: wlan0 Interface doesn't support scanning : Device or resource busy Nov 03 20:25:07 volumio volumio[1073]: info: Cannot use regular scanning, forcing with ap-force Nov 03 20:25:07 volumio sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 03 20:25:07 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:07 volumio volumio[1073]: command failed: Device or resource busy (-16) Nov 03 20:25:07 volumio volumio[1073]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 03 20:25:07 volumio volumio[1073]: command failed: Device or resource busy (-16) Nov 03 20:25:07 volumio volumio[1073]: info: Asound.conf file written Nov 03 20:25:07 volumio sudo[2212]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 20:25:07 volumio sudo[2212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio sudo[2212]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:07 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Nov 03 20:25:07 volumio volumio[1073]: No state is present for card b1 Nov 03 20:25:07 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Nov 03 20:25:07 volumio volumio[1073]: /usr/share/alsa/init/bcm2835:14: control element not found Nov 03 20:25:07 volumio volumio[1073]: No state is present for card b1 Nov 03 20:25:07 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Nov 03 20:25:07 volumio volumio[1073]: No state is present for card Headphones Nov 03 20:25:07 volumio volumio[1073]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Nov 03 20:25:07 volumio volumio[1073]: /usr/share/alsa/init/bcm2835:20: control element not found Nov 03 20:25:07 volumio volumio[1073]: No state is present for card Headphones Nov 03 20:25:07 volumio volumio[1073]: info: Output device has changed, restarting MPD Nov 03 20:25:07 volumio volumio[1073]: info: Output device has changed, restarting Shairport Sync Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:07 volumio sudo[2220]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 20:25:07 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio sudo[2219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 20:25:07 volumio sudo[2219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 20:25:07 volumio volumio[1073]: info: Output device has changed, restarting MPD Nov 03 20:25:07 volumio sudo[2219]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:07 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Nov 03 20:25:07 volumio sudo[2228]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 20:25:07 volumio volumio[1073]: info: Output device has changed, restarting Shairport Sync Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:07 volumio sudo[2228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio sudo[2228]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:07 volumio sudo[2230]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 20:25:07 volumio sudo[2230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 20:25:07 volumio volumio[1073]: info: MPD Permissions set Nov 03 20:25:07 volumio volumio[1073]: info: MPD Permissions set Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:07 volumio volumio[1073]: info: Starting Shairport Sync Nov 03 20:25:07 volumio systemd[1]: mpd.service: Deactivated successfully. Nov 03 20:25:07 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Nov 03 20:25:07 volumio systemd[1]: mpd.service: Consumed 3.332s CPU time. Nov 03 20:25:07 volumio systemd[1]: mpd.socket: Deactivated successfully. Nov 03 20:25:07 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Nov 03 20:25:07 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Nov 03 20:25:07 volumio volumio[1073]: info: Starting Shairport Sync Nov 03 20:25:07 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Nov 03 20:25:07 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Nov 03 20:25:07 volumio sudo[2249]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 20:25:07 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio sudo[2252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 20:25:07 volumio sudo[2252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:07 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Nov 03 20:25:07 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Nov 03 20:25:07 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:25:07 volumio systemd[1]: shairport-sync.service: Consumed 1.145s CPU time. Nov 03 20:25:07 volumio sudo[2251]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 20:25:07 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:25:08 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:08 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:08 volumio volumio[1073]: info: Retrieving Cloud Streaming UI Nov 03 20:25:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:25:08 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Nov 03 20:25:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Nov 03 20:25:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:25:08 volumio volumio[1073]: info: Shairport-Sync Started Nov 03 20:25:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Nov 03 20:25:08 volumio volumio[1073]: info: Getting Tidal Cloud Configuration Nov 03 20:25:08 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:08 volumio sudo[2252]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:08 volumio volumio[1073]: info: Getting Qobuz Cloud Configuration Nov 03 20:25:08 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:08 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:08 volumio volumio[1073]: info: Getting Spotify Cloud Configuration Nov 03 20:25:08 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:08 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:08 volumio volumio[1073]: info: Saving Spotify Acccount Nov 03 20:25:08 volumio volumio[1073]: info: Got Tidal Cloud Configuration Nov 03 20:25:08 volumio volumio[1073]: info: Got it Nov 03 20:25:08 volumio volumio[1073]: info: Got it Nov 03 20:25:08 volumio volumio[1073]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 03 20:25:08 volumio volumio[1073]: info: Shairport-Sync Started Nov 03 20:25:08 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:08 volumio volumio[1073]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Nov 03 20:25:09 volumio mpd[2258]: 2025-11-03T20:25:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 20:25:09 volumio systemd[1]: Started mpd.service - Music Player Daemon. Nov 03 20:25:09 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:09 volumio sudo[2230]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:09 volumio volumio[1073]: error: MPD error: The expression evaluated to a falsy value: Nov 03 20:25:09 volumio volumio[1073]: assert.ok(self.idling) Nov 03 20:25:09 volumio volumio[1073]: error: The expression evaluated to a falsy value: Nov 03 20:25:09 volumio volumio[1073]: assert.ok(self.idling) Nov 03 20:25:09 volumio volumio[1073]: error: updateQueue error: null Nov 03 20:25:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Nov 03 20:25:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Nov 03 20:25:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Nov 03 20:25:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Nov 03 20:25:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Nov 03 20:25:10 volumio sudo[2178]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:10 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 03 20:25:10 volumio volumio[1073]: info: CoreStateMachine::getcurrentVolume Nov 03 20:25:10 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 20:25:10 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:25:10 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:25:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:25:10 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Nov 03 20:25:10 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Nov 03 20:25:10 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 20:25:10 volumio volumio[1073]: info: VolumeController:: Volume=86 Mute =false Nov 03 20:25:10 volumio volumio[1073]: info: CoreStateMachine::pushState Nov 03 20:25:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 20:25:11 volumio volumio[1073]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Nov 03 20:25:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Nov 03 20:25:11 volumio volumio[1073]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Nov 03 20:25:12 volumio volumio[1073]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 03 20:25:12 volumio volumio[1073]: info: Completed starting MyVolumio Plugin Nov 03 20:25:12 volumio volumio[1073]: [Metrics] CommandRouter: 48s 62.89ms Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Retrieving Cloud Streaming UI Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Retrieving Cloud Streaming UI Nov 03 20:25:12 volumio volumio[1073]: info: Getting Tidal Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Getting Qobuz Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Getting Spotify Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Saving Spotify Acccount Nov 03 20:25:12 volumio volumio[1073]: info: Got Tidal Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Got it Nov 03 20:25:12 volumio volumio[1073]: info: Got it Nov 03 20:25:12 volumio volumio[1073]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 03 20:25:12 volumio volumio[1073]: info: Getting Tidal Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Getting Qobuz Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Getting Spotify Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Asking plugin for UI Config Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: info: Saving Spotify Acccount Nov 03 20:25:12 volumio volumio[1073]: info: Got Tidal Cloud Configuration Nov 03 20:25:12 volumio volumio[1073]: info: Got it Nov 03 20:25:12 volumio volumio[1073]: info: Got it Nov 03 20:25:12 volumio volumio[1073]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 20:25:12 volumio volumio[1073]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::Reload Ui Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Nov 03 20:25:12 volumio volumio[1073]: info: Wizard terminated Successfully Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 20:25:12 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 20:25:13 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 20:25:13 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 20:25:13 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 20:25:13 volumio volumio[1073]: info: Version has changed, forcing UI Reload Nov 03 20:25:13 volumio volumio[1073]: info: CoreCommandRouter::Reload Ui Nov 03 20:25:14 volumio sudo[2301]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:25:14 volumio sudo[2301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:14 volumio sudo[2302]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:25:14 volumio sudo[2302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:14 volumio sudo[2301]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:14 volumio sudo[2302]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:14 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 03 20:25:14 volumio sudo[2308]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 20:25:14 volumio sudo[2308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:14 volumio sudo[2308]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:14 volumio sudo[2310]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 20:25:14 volumio sudo[2310]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:14 volumio sudo[2310]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:14 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:14 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 20:25:14 volumio volumio[1073]: info: Received Get System Info Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:25:14 volumio volumio[1073]: info: Discovery: Getting this device information Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:14 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:14 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:14 volumio volumio[1073]: info: Listing playlists Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 20:25:14 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 20:25:15 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:15 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 20:25:16 volumio volumio[1073]: info: Received Get System Info Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:25:16 volumio volumio[1073]: info: Discovery: Getting this device information Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:16 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:25:16 volumio volumio-remote-updater[709]: Test mode disabled Nov 03 20:25:16 volumio volumio-remote-updater[709]: Alpha mode disabled Nov 03 20:25:16 volumio volumio-remote-updater[709]: Alpha legacy test mode disabled Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 03 20:25:16 volumio volumio[1073]: info: MyVolumio login type: Token Nov 03 20:25:16 volumio volumio[1073]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 20:25:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 20:25:17 volumio volumio[1073]: info: Received Get System Info Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:25:17 volumio volumio[1073]: info: Discovery: Getting this device information Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Nov 03 20:25:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:25:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 03 20:25:17 volumio volumio[1073]: info: MyVolumio login type: Token Nov 03 20:25:17 volumio volumio[1073]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 03 20:25:18 volumio volumio[1073]: info: MyVolumio token set successfully Nov 03 20:25:18 volumio volumio[1073]: info: MYVOLUMIO: Adding device Nov 03 20:25:18 volumio volumio[1073]: info: MYVOLUMIO: Evaluating Server Nov 03 20:25:18 volumio volumio[1073]: info: MyVolumio status changed Nov 03 20:25:18 volumio volumio[1073]: info: Streaming services startup Nov 03 20:25:18 volumio volumio[1073]: info: Starting Streaming Daemon Nov 03 20:25:18 volumio volumio[1073]: info: Removing browser output: myVolumio user plan is not superstar Nov 03 20:25:18 volumio volumio[1073]: info: Removing audio output: Nov 03 20:25:18 volumio volumio[1073]: info: Stoppping Tunnel 1 Nov 03 20:25:18 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Nov 03 20:25:18 volumio sudo[2348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 20:25:18 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:18 volumio sudo[2350]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 03 20:25:18 volumio sudo[2350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 20:25:18 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Nov 03 20:25:18 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:18 volumio volumio[1073]: error: Cannot start Volumio Streaming Daemon Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio volumio[1073]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 20:25:18 volumio volumio[1073]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 20:25:18 volumio sudo[2350]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:18 volumio volumio[1073]: info: Remote SSH Stopped Nov 03 20:25:18 volumio setdatetime-helper.sh[2353]: Time is not synchronized. Attempting to sync... Nov 03 20:25:18 volumio sudo[2361]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 03 Nov 2025 19:25:18 GMT#015' Nov 03 20:25:18 volumio sudo[2361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 03 20:25:18 volumio setdatetime-helper.sh[2362]: Mon Nov 3 20:25:18 CET 2025 Nov 03 20:25:18 volumio systemd-journald[366]: Time jumped backwards, rotating. Nov 03 20:25:18 volumio sudo[2361]: pam_unix(sudo:session): session closed for user root Nov 03 20:25:18 volumio setdatetime-helper.sh[2353]: Time synchronized successfully. Nov 03 20:25:18 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Nov 03 20:25:18 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Nov 03 20:25:18 volumio volumio[1073]: info: Setting Geolocation for MyVolumio to as1 Nov 03 20:25:18 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:18 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:18 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:25:18 volumio volumio[1073]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Nov 03 20:25:18 volumio volumio[1073]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:25:18 volumio volumio[1073]: Error: Unable to resolve or reject the same promise twice Nov 03 20:25:18 volumio volumio[1073]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 03 20:25:18 volumio volumio[1073]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32371) Nov 03 20:25:18 volumio volumio[1073]: at Socket.emit (node:events:514:28) Nov 03 20:25:18 volumio volumio[1073]: at addChunk (node:internal/streams/readable:343:12) Nov 03 20:25:18 volumio volumio[1073]: at readableAddChunk (node:internal/streams/readable:316:9) Nov 03 20:25:18 volumio volumio[1073]: at Readable.push (node:internal/streams/readable:253:10) Nov 03 20:25:18 volumio volumio[1073]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Nov 03 20:25:18 volumio volumio[1073]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:25:19 volumio sudo[2378]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 20:24' Nov 03 20:25:19 volumio sudo[2378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"