Feb 10 17:05:00 volumio dhcpcd[826]: wlan0: leased 192.168.1.116 for 43200 seconds
Feb 10 17:05:00 volumio avahi-daemon[731]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.116.
Feb 10 17:05:00 volumio dhcpcd[826]: wlan0: adding route to 192.168.1.0/24
Feb 10 17:05:00 volumio dhcpcd[826]: wlan0: adding default route via 192.168.1.1
Feb 10 17:05:00 volumio avahi-daemon[731]: New relevant interface wlan0.IPv4 for mDNS.
Feb 10 17:05:00 volumio avahi-daemon[731]: Registering new address record for 192.168.1.116 on wlan0.IPv4.
Feb 10 17:05:00 volumio systemd[1]: welcome.service: Deactivated successfully.
Feb 10 17:05:00 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 10 17:05:00 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 10 17:05:00 volumio wireless.js[754]: WIRELESS.JS - INFO: trying...
Feb 10 17:05:00 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 10 17:05:00 volumio systemd[1]: Started nmbd.service - Samba NMB Daemon.
Feb 10 17:05:00 volumio welcome[1266]: Resolved ip:[1] 192.168.1.116
Feb 10 17:05:00 volumio systemd[1]: Starting winbind.service - Samba Winbind Daemon...
Feb 10 17:05:00 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 10 17:05:00 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
Feb 10 17:05:00 volumio sudo[1302]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 10 17:05:00 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:00 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:00 volumio sudo[1306]:     root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:05:00 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 10 17:05:00 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:00 volumio wireless.js[754]: WIRELESS.JS - INFO: ... wlan0 IPv4 is 192.168.1.116, ipV6 is undefined
Feb 10 17:05:00 volumio wireless.js[754]: WIRELESS.JS - INFO: Connected to SSID: Splly_5G
Feb 10 17:05:00 volumio wireless.js[754]: WIRELESS.JS - INFO: It's done! AP
Feb 10 17:05:00 volumio wireless.js[754]: WIRELESS.JS - INFO: Restarting avahi-daemon...
Feb 10 17:05:00 volumio sudo[1316]:     root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart avahi-daemon
Feb 10 17:05:00 volumio sudo[1316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 10 17:05:00 volumio winbindd[1295]: [2026/02/10 17:05:00.692950,  0] ../../source3/winbindd/winbindd.c:1440(main)
Feb 10 17:05:00 volumio winbindd[1295]:   winbindd version 4.17.8-Raspbian started.
Feb 10 17:05:00 volumio winbindd[1295]:   Copyright Andrew Tridgell and the Samba Team 1992-2022
Feb 10 17:05:00 volumio winbindd[1295]: [2026/02/10 17:05:00.717450,  0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache)
Feb 10 17:05:00 volumio winbindd[1295]:   initialize_winbindd_cache: clearing cache and re-creating with version number 2
Feb 10 17:05:00 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 10 17:05:00 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 10 17:05:00 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:00 volumio systemd[1]: shairport-sync.service: Consumed 1.623s CPU time.
Feb 10 17:05:00 volumio avahi-daemon[731]: Got SIGTERM, quitting.
Feb 10 17:05:00 volumio avahi-daemon[731]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.116.
Feb 10 17:05:00 volumio avahi-daemon[731]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Feb 10 17:05:00 volumio avahi-daemon[731]: avahi-daemon 0.8 exiting.
Feb 10 17:05:00 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack...
Feb 10 17:05:00 volumio systemd[1]: avahi-daemon.service: Deactivated successfully.
Feb 10 17:05:00 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack.
Feb 10 17:05:00 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack...
Feb 10 17:05:00 volumio systemd[1]: Started winbind.service - Samba Winbind Daemon.
Feb 10 17:05:00 volumio systemd[1]: Starting smbd.service - Samba SMB Daemon...
Feb 10 17:05:00 volumio avahi-daemon[1319]: Process 731 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid)
Feb 10 17:05:00 volumio avahi-daemon[1319]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109).
Feb 10 17:05:00 volumio avahi-daemon[1319]: Successfully dropped root privileges.
Feb 10 17:05:00 volumio avahi-daemon[1319]: avahi-daemon 0.8 starting up.
Feb 10 17:05:00 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Successfully called chroot().
Feb 10 17:05:00 volumio avahi-daemon[1319]: Successfully dropped remaining capabilities.
Feb 10 17:05:00 volumio avahi-daemon[1319]: No service file found in /etc/avahi/services.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.116.
Feb 10 17:05:00 volumio avahi-daemon[1319]: New relevant interface wlan0.IPv4 for mDNS.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Feb 10 17:05:00 volumio avahi-daemon[1319]: New relevant interface lo.IPv4 for mDNS.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Network interface enumeration completed.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Registering new address record for 192.168.1.116 on wlan0.IPv4.
Feb 10 17:05:00 volumio avahi-daemon[1319]: Registering new address record for 127.0.0.1 on lo.IPv4.
Feb 10 17:05:00 volumio sudo[1316]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:00 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:00 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:00 volumio volumio[1207]: info: -----            Volumio3              ----
Feb 10 17:05:00 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:00 volumio volumio[1207]: info: -----          System startup          ----
Feb 10 17:05:00 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:01 volumio wireless.js[754]: WIRELESS.JS - INFO: Notified systemd about wireless ready
Feb 10 17:05:01 volumio smbd[1352]: [2026/02/10 17:05:01.394151,  0] ../../source3/smbd/server.c:1741(main)
Feb 10 17:05:01 volumio smbd[1352]:   smbd version 4.17.8-Raspbian started.
Feb 10 17:05:01 volumio smbd[1352]:   Copyright Andrew Tridgell and the Samba Team 1992-2022
Feb 10 17:05:01 volumio avahi-daemon[1319]: Server startup complete. Host name is volumio.local. Local service cookie is 2666639038.
Feb 10 17:05:01 volumio ntpd[1020]: IO: Listen normally on 3 wlan0 192.168.1.116:123
Feb 10 17:05:01 volumio ntpd[1020]: IO: new interface(s) found: waking up resolver
Feb 10 17:05:01 volumio ntpd[1020]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 10 17:05:01 volumio ntpd[1020]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
Feb 10 17:05:01 volumio ntpd[1020]: DNS: Pool taking: 89.109.251.28
Feb 10 17:05:01 volumio ntpd[1020]: DNS: Pool taking: 5.23.48.22
Feb 10 17:05:01 volumio ntpd[1020]: DNS: Pool taking: 95.31.10.75
Feb 10 17:05:01 volumio ntpd[1020]: DNS: Pool taking: 149.154.70.34
Feb 10 17:05:01 volumio ntpd[1020]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8
Feb 10 17:05:02 volumio systemd[1]: Started smbd.service - Samba SMB Daemon.
Feb 10 17:05:02 volumio systemd[1]: Reached target multi-user.target - Multi-User System.
Feb 10 17:05:02 volumio systemd[1]: Reached target graphical.target - Graphical Interface.
Feb 10 17:05:02 volumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP...
Feb 10 17:05:02 volumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Feb 10 17:05:02 volumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP.
Feb 10 17:05:02 volumio systemd[1]: Startup finished in 13.945s (kernel) + 24.914s (userspace) = 38.860s.
Feb 10 17:05:02 volumio ntpd[1020]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 10 17:05:02 volumio ntpd[1020]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 192.36.143.130
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 90.188.9.144
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 92.118.113.24
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 93.95.100.85
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 2001:678:68c::3
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 2a02:6bf:f000:1:4::21
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 2a03:aa00::136:55
Feb 10 17:05:02 volumio ntpd[1020]: DNS: Pool taking: 2a02:6bf:f000:1:4::22
Feb 10 17:05:02 volumio ntpd[1020]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8
Feb 10 17:05:03 volumio volumio[1207]: info: MYVOLUMIO Environment detected
Feb 10 17:05:03 volumio volumio[1207]: info: Plugin folders cleanup
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning into folder /volumio/app/plugins/
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category audio_interface
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category miscellanea
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category music_service
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category plugins.json
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category system_controller
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category user_interface
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning into folder /data/plugins/
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category music_service
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category system_controller
Feb 10 17:05:03 volumio volumio[1207]: info: Scanning category system_hardware
Feb 10 17:05:03 volumio volumio[1207]: info: Plugin folders cleanup completed
Feb 10 17:05:03 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:03 volumio volumio[1207]: info: -----      Core plugins startup        ----
Feb 10 17:05:03 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:03 volumio volumio[1207]: info: Loading plugins from folder /volumio/app/plugins/
Feb 10 17:05:03 volumio volumio[1207]: info: Adding plugin upnp to MyMusic Plugins
Feb 10 17:05:03 volumio volumio[1207]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 10 17:05:03 volumio volumio[1207]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 10 17:05:03 volumio volumio[1207]: info: Loading plugins from folder /data/plugins/
Feb 10 17:05:03 volumio volumio[1207]: info: Loading plugin "system"...
Feb 10 17:05:03 volumio volumio[1207]: info: Loading plugin "appearance"...
Feb 10 17:05:03 volumio ntpd[1020]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 10 17:05:03 volumio ntpd[1020]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
Feb 10 17:05:03 volumio ntpd[1020]: DNS: Pool skipping: 93.95.100.85
Feb 10 17:05:03 volumio ntpd[1020]: DNS: Pool taking: 82.202.138.88
Feb 10 17:05:03 volumio ntpd[1020]: DNS: Pool taking: 85.193.65.152
Feb 10 17:05:03 volumio ntpd[1020]: DNS: Pool taking: 188.225.9.167
Feb 10 17:05:03 volumio ntpd[1020]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8
Feb 10 17:05:04 volumio volumio[1207]: info: Loading plugin "network"...
Feb 10 17:05:04 volumio volumio[1207]: info: Refreshing Cached IP Addresses
Feb 10 17:05:04 volumio sudo[1376]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:05:04 volumio sudo[1376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:04 volumio sudo[1376]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:04 volumio sudo[1389]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 10 17:05:04 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:04 volumio sudo[1377]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:05:04 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:04 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:04 volumio volumio[1207]: info: Loading plugin "services"...
Feb 10 17:05:04 volumio volumio[1207]: info: Loading plugin "alsa_controller"...
Feb 10 17:05:04 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:05:04 volumio volumio[1207]: info: Loading plugin "wizard"...
Feb 10 17:05:04 volumio ntpd[1020]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 10 17:05:04 volumio volumio[1207]: info: Loading plugin "networkfs"...
Feb 10 17:05:05 volumio ntpd[1020]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
Feb 10 17:05:05 volumio ntpd[1020]: DNS: Pool taking: 91.207.136.55
Feb 10 17:05:05 volumio ntpd[1020]: DNS: Pool taking: 162.159.200.1
Feb 10 17:05:05 volumio ntpd[1020]: DNS: Pool taking: 82.146.53.58
Feb 10 17:05:05 volumio ntpd[1020]: DNS: Pool taking: 89.109.251.22
Feb 10 17:05:05 volumio ntpd[1020]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8
Feb 10 17:05:05 volumio volumio[1207]: info: Starting Udev Watcher for removable devices
Feb 10 17:05:05 volumio sudo[1411]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Splly,password=splly459063,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.130/@music /mnt/NAS/Music
Feb 10 17:05:05 volumio sudo[1411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:05 volumio kernel: netfs: FS-Cache loaded
Feb 10 17:05:05 volumio volumio[1207]: info: Ignoring mount for partition: boot
Feb 10 17:05:05 volumio volumio[1207]: info: Ignoring mount for partition: volumio
Feb 10 17:05:05 volumio volumio[1207]: info: Ignoring mount for partition: volumio_data
Feb 10 17:05:05 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 10 17:05:05 volumio volumio[1207]: info: Loading plugin "volumio_command_line_client"...
Feb 10 17:05:05 volumio volumio[1207]: info: Loading plugin "upnp"...
Feb 10 17:05:05 volumio volumio[1207]: info: [1770732305183] Starting Upmpd Daemon
Feb 10 17:05:05 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 10 17:05:05 volumio volumio[1207]: info: Loading plugin "my_music"...
Feb 10 17:05:05 volumio volumio[1207]: info: Loading plugin "mpd"...
Feb 10 17:05:05 volumio kernel: Key type cifs.spnego registered
Feb 10 17:05:05 volumio kernel: Key type cifs.idmap registered
Feb 10 17:05:05 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Feb 10 17:05:05 volumio kernel: CIFS: Attempting to mount //192.168.1.130/@music
Feb 10 17:05:05 volumio volumio-remote-updater[752]: [2026-02-10 17:05:05] [connect] Successful connection
Feb 10 17:05:05 volumio volumio[1207]: info: Loading plugin "upnp_browser"...
Feb 10 17:05:06 volumio sudo[1411]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:06 volumio volumio[1207]: info: Starting UPNP Browser
Feb 10 17:05:06 volumio volumio[1207]: info: Loading plugin "alarm-clock"...
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "airplay_emulation"...
Feb 10 17:05:07 volumio volumio[1207]: info: Starting Shairport Sync
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "last_100"...
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "webradio"...
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "i2s_dacs"...
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "volumiodiscovery"...
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** For more information see 
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** For more information see 
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 10 17:05:07 volumio volumio[1207]: *** WARNING *** For more information see 
Feb 10 17:05:07 volumio node[1207]: *** WARNING *** For more information see 
Feb 10 17:05:07 volumio volumio[1207]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 10 17:05:07 volumio volumio[1207]: info: Discovery: Started advertising with name: Volumio
Feb 10 17:05:07 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "autostart"...
Feb 10 17:05:07 volumio volumio[1207]: info: Applying required configuration parameters for plugin autostart
Feb 10 17:05:07 volumio volumio[1207]: info: AutoStart - onVolumioStart -  read config.json
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "outputs"...
Feb 10 17:05:07 volumio volumio[1207]: info: Loading plugin "albumart"...
Feb 10 17:05:39 volumio ntpd[1020]: CLOCK: time stepped by 32.018021
Feb 10 17:05:39 volumio ntpd[1020]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes
Feb 10 17:05:39 volumio volumio[1207]: info: Plugin example_plugin is not enabled
Feb 10 17:05:39 volumio volumio[1207]: info: Loading plugin "inputs"...
Feb 10 17:05:39 volumio volumio[1207]: info: Loading plugin "updater_comm"...
Feb 10 17:05:40 volumio volumio[1207]: info: Plugin mpdemulation is not enabled
Feb 10 17:05:40 volumio volumio[1207]: info: Loading plugin "rest_api"...
Feb 10 17:05:40 volumio volumio[1207]: info: Loading plugin "websocket"...
Feb 10 17:05:40 volumio volumio[1207]: info: Starting Socket.io Server version 1.7.4
Feb 10 17:05:40 volumio volumio[1207]: info: Loading plugin "yandex_music"...
Feb 10 17:05:40 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:40 volumio volumio[1450]: Forking 3 albumart workers
Feb 10 17:05:42 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully.
Feb 10 17:05:43 volumio dhcpcd[711]: timed out
Feb 10 17:05:43 volumio sh[688]: timed out
Feb 10 17:05:43 volumio sh[614]: ifup: failed to bring up eth0
Feb 10 17:05:43 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Feb 10 17:05:43 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Feb 10 17:05:44 volumio volumio[1207]: info: Applying required configuration parameters for plugin yandex_music
Feb 10 17:05:44 volumio volumio[1207]: info: Loading plugin "backup_restore"...
Feb 10 17:05:45 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 10 17:05:45 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2.
Feb 10 17:05:45 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 10 17:05:45 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 10 17:05:45 volumio volumio[1460]: Starting albumart workers
Feb 10 17:05:45 volumio upmpdcli[1494]: Could not open config: /tmp/upmpdcli.conf
Feb 10 17:05:45 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 10 17:05:45 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 10 17:05:46 volumio volumio[1461]: Starting albumart workers
Feb 10 17:05:46 volumio volumio[1207]: info: Applying required configuration parameters for plugin backup_restore
Feb 10 17:05:46 volumio volumio[1207]: info: Loading plugin "Bluetoothremote"...
Feb 10 17:05:46 volumio volumio[1462]: Starting albumart workers
Feb 10 17:05:48 volumio volumio[1207]: info: Applying required configuration parameters for plugin Bluetoothremote
Feb 10 17:05:48 volumio volumio[1207]: info: Loading i18n strings for locale en
Feb 10 17:05:48 volumio volumio[1207]: Updating browse sources language
Feb 10 17:05:48 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::initPlayerControls
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 10 17:05:49 volumio volumio[1207]: Express server listening on port 3000
Feb 10 17:05:49 volumio volumio[1207]:  [Metrics]  WebUI:  17s 730.47ms 
Feb 10 17:05:49 volumio volumio[1207]: info: CoreStateMachine::resetVolumioState
Feb 10 17:05:49 volumio volumio[1207]: info: CoreStateMachine::getcurrentVolume
Feb 10 17:05:49 volumio volumio[1207]: info: CoreCommandRouter::volumioRetrievevolume
Feb 10 17:05:49 volumio sudo[1532]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:05:49 volumio sudo[1532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:49 volumio sudo[1534]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:05:49 volumio sudo[1534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:49 volumio sudo[1532]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:49 volumio sudo[1534]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:49 volumio volumio[1207]: info: Volumio Network Manager: Network status updated: 2
Feb 10 17:05:50 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Feb 10 17:05:50 volumio volumio[1207]: info: VolumeController:: Volume=20 Mute =false
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::updateTrackBlock
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrackBlock
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioRetrievevolume
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:50 volumio volumio[1207]: info: Executing start script for DAC IQaudIO DAC Plus
Feb 10 17:05:50 volumio volumio[1207]: info: Reloading queue from file
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::setRepeat false single undefined
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::setRandom null
Feb 10 17:05:50 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:05:50 volumio volumio[1207]: info: Setting Device type: Raspberry PI
Feb 10 17:05:50 volumio volumio[1207]: info: DAC script executed
Feb 10 17:05:50 volumio volumio[1207]: info: Completed loading Core Plugins
Feb 10 17:05:50 volumio volumio[1207]: info: Preparing to generate the ALSA configuration file
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:50 volumio volumio[1207]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Feb 10 17:05:50 volumio volumio[1207]: info: USB Boot Capable - System SBC Revision found in cpuinfo:  d03115
Feb 10 17:05:50 volumio volumio[1207]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:05:50 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:50 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:50 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:05:51 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116:3000 from 192.168.1.146 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2
Feb 10 17:05:51 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Feb 10 17:05:51 volumio sudo[1554]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 10 17:05:51 volumio sudo[1554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:51 volumio volumio[1207]: info: VolumeController:: Volume=20 Mute =false
Feb 10 17:05:51 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:05:51 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:05:51 volumio volumio[1207]: info: Listing playlists
Feb 10 17:05:51 volumio volumio[1207]: info: Listing playlists
Feb 10 17:05:51 volumio volumio[1207]: info: Discovery: adding 66aceec2-d850-4a76-9577-f1d7e689c787
Feb 10 17:05:51 volumio volumio[1207]: info: Discovery: Found device Volumio
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:51 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:51 volumio volumio[1207]: info: Discovery: this is already registered,  66aceec2-d850-4a76-9577-f1d7e689c787
Feb 10 17:05:51 volumio volumio[1207]: info: Discovery: Found device Volumio
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:51 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:51 volumio volumio[1207]: info: Asound.conf file unchanged, so no further update is needed
Feb 10 17:05:51 volumio volumio[1207]: info: Output device has changed, restarting MPD
Feb 10 17:05:51 volumio volumio[1207]: info: Output device has changed, restarting Shairport Sync
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:51 volumio sudo[1557]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 10 17:05:51 volumio sudo[1559]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 10 17:05:51 volumio sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:51 volumio sudo[1557]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:51 volumio sudo[1559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:51 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 10 17:05:51 volumio volumio[1207]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 10 17:05:51 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 10 17:05:51 volumio volumio[1207]: info: ___________ START PLUGINS ___________
Feb 10 17:05:51 volumio volumio[1207]: info: ControllerMpd::onStart: Initializing MPD
Feb 10 17:05:51 volumio volumio[1207]: info: Creating MPD Configuration file
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 10 17:05:51 volumio volumio[1207]: info: [1770732351715] CoreMusicLibrary::Adding element Media Servers
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:05:51 volumio sudo[1567]:     root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 10 17:05:51 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 10 17:05:51 volumio sudo[1572]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 10 17:05:51 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:51 volumio sudo[1569]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 10 17:05:51 volumio volumio[1207]: info: UPNP Browser: Client initialized successfully
Feb 10 17:05:51 volumio sudo[1569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:51 volumio sudo[1569]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:51 volumio sudo[1571]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 10 17:05:51 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:51 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 10 17:05:51 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 10 17:05:51 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 10 17:05:51 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 10 17:05:51 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 10 17:05:52 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 10 17:05:52 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 10 17:05:52 volumio volumio[1207]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:52 volumio sudo[1581]:     root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 10 17:05:52 volumio sudo[1581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 10 17:05:52 volumio sudo[1586]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 10 17:05:52 volumio sudo[1581]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:52 volumio volumio[1207]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 10 17:05:52 volumio volumio[1207]: info: [1770732352180] CoreMusicLibrary::Adding element Last_100
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 10 17:05:52 volumio volumio[1207]: info: [1770732352182] CoreMusicLibrary::Adding element Webradio
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:05:52 volumio volumio[1207]: info: Initializing BBC Radios
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:52 volumio volumio[1207]: info: AutoStart - onStart
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 10 17:05:52 volumio volumio[1207]: info: [1770732352591] CoreMusicLibrary::Adding element Yandex Music
Feb 10 17:05:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:05:52 volumio volumio[1207]: Cannot find translation for source Yandex Music
Feb 10 17:05:52 volumio volumio-remote-updater[752]: [2026-02-10 17:05:52] [connect] Successful connection
Feb 10 17:05:52 volumio volumio[1207]: error: Plugin yandex_music failed to start! TypeError: Cannot read properties of undefined (reading 'get')
Feb 10 17:05:52 volumio volumio[1207]: info: Loading i18n strings for locale en
Feb 10 17:05:52 volumio volumio[1207]: info: Volumio Calling Home
Feb 10 17:05:54 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:05:54 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:05:54 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:05:54 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:54 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:54 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:05:54 volumio volumio[1207]: info: MPD Permissions set
Feb 10 17:05:54 volumio volumio[1207]: info: MPD Permissions set
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:05:55 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:55 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:05:55 volumio volumio-remote-updater[752]: [2026-02-10 17:05:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770732352 101
Feb 10 17:05:55 volumio volumio[1207]: 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: 4
Feb 10 17:05:55 volumio volumio[1207]: info: Volumio called home
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:05:55 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:05:56 volumio volumio[1207]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Feb 10 17:05:56 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116:3000 from 192.168.1.146 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Feb 10 17:05:56 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 10 17:05:56 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 10 17:05:57 volumio volumio[1207]: info: Starting Shairport Sync
Feb 10 17:05:57 volumio volumio[1207]: info: Starting Shairport Sync
Feb 10 17:05:57 volumio volumio[1207]: info: Starting Shairport Sync
Feb 10 17:05:57 volumio sudo[1624]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 10 17:05:57 volumio sudo[1630]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 10 17:05:57 volumio sudo[1630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:57 volumio sudo[1618]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 10 17:05:57 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:57 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:05:57 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116:3000 from 192.168.1.146 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Feb 10 17:05:57 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Feb 10 17:05:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 10 17:05:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 10 17:05:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:57 volumio systemd[1]: shairport-sync.service: Consumed 1.214s CPU time.
Feb 10 17:05:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:57 volumio sudo[1630]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:57 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 10 17:05:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 10 17:05:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 10 17:05:57 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:57 volumio volumio[1207]: info: Shairport-Sync Started
Feb 10 17:05:57 volumio mpd[1587]: 2026-02-10T17:05:57 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 10 17:05:57 volumio volumio[1207]: Error adding Membership: Error: addMembership EINVAL
Feb 10 17:05:57 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 10 17:05:57 volumio sudo[1559]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:57 volumio volumio[1207]: info: Shairport-Sync Started
Feb 10 17:05:57 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root
Feb 10 17:05:57 volumio volumio[1207]: info: Shairport-Sync Started
Feb 10 17:05:57 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:05:57 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:05:57 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:05:57 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:57 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:57 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:05:58 volumio volumio[1207]: info: Completed starting Core Plugins
Feb 10 17:05:58 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:58 volumio volumio[1207]: info: -----    MyVolumio plugins startup     ----
Feb 10 17:05:58 volumio volumio[1207]: info: -------------------------------------------
Feb 10 17:05:58 volumio volumio[1207]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 10 17:05:58 volumio volumio[1207]: info: MPD running with PID1587
Feb 10 17:05:58 volumio volumio[1207]:  ,establishing connection
Feb 10 17:05:58 volumio volumio[1207]: error: MPD error: The expression evaluated to a falsy value:
Feb 10 17:05:58 volumio volumio[1207]:   assert.ok(self.idling)
Feb 10 17:05:58 volumio volumio[1207]: error: The expression evaluated to a falsy value:
Feb 10 17:05:58 volumio volumio[1207]:   assert.ok(self.idling)
Feb 10 17:05:58 volumio volumio[1207]: error: MPD error: The expression evaluated to a falsy value:
Feb 10 17:05:58 volumio volumio[1207]:   assert.ok(self.idling)
Feb 10 17:05:58 volumio volumio[1207]: error: The expression evaluated to a falsy value:
Feb 10 17:05:58 volumio volumio[1207]:   assert.ok(self.idling)
Feb 10 17:05:58 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:58 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:05:58 volumio volumio[1207]: error: updateQueue error: null
Feb 10 17:05:59 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:05:59 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3.
Feb 10 17:06:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 10 17:06:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 10 17:06:01 volumio sudo[1554]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:01 volumio volumio[1207]: info: Upmpdcli Daemon Started
Feb 10 17:06:03 volumio volumio[1207]: error: Failed LSINFO: Error:  [50@0] {lsinfo} No such directory
Feb 10 17:06:03 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.180 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Feb 10 17:06:03 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:03 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:03 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 10 17:06:03 volumio volumio[1207]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 10 17:06:03 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:06:03 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Feb 10 17:06:06 volumio volumio[1207]: info: Adding plugin bluetooth to MyMusic Plugins
Feb 10 17:06:06 volumio volumio[1207]: info: Adding plugin multiroom to MyMusic Plugins
Feb 10 17:06:06 volumio volumio[1207]: info: Adding plugin metavolumio to MyMusic Plugins
Feb 10 17:06:06 volumio volumio[1207]: info: Adding plugin cd_controller to MyMusic Plugins
Feb 10 17:06:07 volumio volumio[1207]: info: Adding plugin qobuzconnect to MyMusic Plugins
Feb 10 17:06:07 volumio volumio[1207]: info: Adding plugin smart_inputs to MyMusic Plugins
Feb 10 17:06:07 volumio volumio[1207]: info: Adding plugin tidalconnect to MyMusic Plugins
Feb 10 17:06:07 volumio volumio[1207]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Feb 10 17:06:11 volumio volumio[1207]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Feb 10 17:06:11 volumio volumio[1207]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Feb 10 17:06:11 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:11 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:11 volumio volumio[1207]: info: Starting MyVolumio Remote Streaming Endpoints
Feb 10 17:06:11 volumio volumio[1207]: info: MyVolumio login type: Token
Feb 10 17:06:12 volumio volumio[1207]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Feb 10 17:06:12 volumio volumio[1207]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Feb 10 17:06:13 volumio upmpdcli[1720]: writing RSA key
Feb 10 17:06:16 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 10 17:06:16 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 10 17:06:16 volumio volumio[1207]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 10 17:06:17 volumio volumio[1207]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 10 17:06:17 volumio volumio[1207]: info: Streaming services startup
Feb 10 17:06:17 volumio volumio[1207]: info: Starting Streaming Daemon
Feb 10 17:06:17 volumio sudo[1737]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 10 17:06:17 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:17 volumio volumio[1207]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 10 17:06:17 volumio sudo[1737]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:17 volumio volumio[1207]: info: AutoStart - Plugin is starting
Feb 10 17:06:17 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:17 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:17 volumio volumio[1207]: info: AutoStart - start playing
Feb 10 17:06:17 volumio volumio[1207]: info: AutoStart - start playing with no specific position
Feb 10 17:06:17 volumio volumio[1207]: info: CoreCommandRouter::volumioPlay
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::play index 0
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::stop
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::play index undefined
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 10 17:06:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:17 volumio volumio[1207]: info: CoreStateMachine::startPlaybackTimer
Feb 10 17:06:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand stop
Feb 10 17:06:17 volumio volumio[1207]: info: sendMpdCommand stop took 50 milliseconds
Feb 10 17:06:17 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand clear
Feb 10 17:06:17 volumio volumio[1207]: error: Cannot start Volumio Streaming Daemon
Feb 10 17:06:17 volumio volumio[1207]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 10 17:06:17 volumio volumio[1207]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 10 17:06:17 volumio volumio[1207]: info:
Feb 10 17:06:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:17 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:17 volumio volumio[1207]: info: sendMpdCommand clear took 123 milliseconds
Feb 10 17:06:17 volumio volumio[1207]: info:
Feb 10 17:06:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:17 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:17 volumio volumio[1207]: info:
Feb 10 17:06:17 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:17 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:17 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:17 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:17 volumio volumio[1207]: error: updateQueue error: null
Feb 10 17:06:17 volumio volumio[1207]: error: updateQueue error: null
Feb 10 17:06:17 volumio volumio[1207]: error: updateQueue error: null
Feb 10 17:06:17 volumio volumio[1207]: info: ------------------------------ 131ms
Feb 10 17:06:17 volumio volumio[1207]: info: ------------------------------ 54ms
Feb 10 17:06:17 volumio volumio[1207]: info: ------------------------------ 53ms
Feb 10 17:06:17 volumio volumio[1207]: info: Bluetoothremote--- Checking for trusted devices to reconnect...
Feb 10 17:06:17 volumio volumio[1207]: info: Bluetoothremote--- Device list cleared and placeholder written.
Feb 10 17:06:18 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116:3000 from 192.168.1.146 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Feb 10 17:06:18 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:18 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:18 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:06:18 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:06:18 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:06:18 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:18 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:18 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:06:18 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.21
Feb 10 17:06:18 volumio volumio[1207]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 10 17:06:18 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116:3000 from 192.168.1.146 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Feb 10 17:06:18 volumio bluetoothd[732]: Adv Monitor app :1.21 disconnected from D-Bus
Feb 10 17:06:18 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac"
Feb 10 17:06:18 volumio volumio[1207]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio volumio[1207]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac" took 323 milliseconds
Feb 10 17:06:19 volumio volumio[1207]: verbose: MPD COMMAND [object Object]
Feb 10 17:06:19 volumio volumio[1207]: verbose: MPD COMMAND [object Object]
Feb 10 17:06:19 volumio volumio[1207]: verbose: MPD COMMAND [object Object]
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.24
Feb 10 17:06:19 volumio volumio[1207]: info: Bluetoothremote--- Device found: Press scan to detect BT device - xx
Feb 10 17:06:19 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:06:19 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:06:19 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:06:19 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:19 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:19 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 159ms
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 128ms
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 112ms
Feb 10 17:06:19 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 10 17:06:19 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand play
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio volumio[1207]: info:
Feb 10 17:06:19 volumio volumio[1207]: ---------------------------- MPD announces system playlist update
Feb 10 17:06:19 volumio volumio[1207]: info: Ignoring MPD Status Update
Feb 10 17:06:19 volumio bluetoothd[732]: Adv Monitor app :1.24 disconnected from D-Bus
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 156ms
Feb 10 17:06:19 volumio volumio[1207]: info: sendMpdCommand play took 150 milliseconds
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 150ms
Feb 10 17:06:19 volumio volumio[1207]: info: ------------------------------ 149ms
Feb 10 17:06:19 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.22
Feb 10 17:06:19 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.23
Feb 10 17:06:19 volumio bluetoothd[732]: Adv Monitor app :1.22 disconnected from D-Bus
Feb 10 17:06:19 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:19 volumio bluetoothd[732]: Adv Monitor app :1.23 disconnected from D-Bus
Feb 10 17:06:19 volumio volumio[1207]: info: Bluetoothremote--- Reconnecting trusted device: splly (88:54:8E:24:52:C4)
Feb 10 17:06:19 volumio volumio[1207]: info: Bluetoothremote--- Reconnecting trusted device: T33 (85:64:0D:CC:42:B2)
Feb 10 17:06:19 volumio volumio[1207]: info: Bluetoothremote--- Reconnecting trusted device: Yandex Remote 2 (54:A9:C8:84:2D:24)
Feb 10 17:06:19 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.25
Feb 10 17:06:19 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.26
Feb 10 17:06:20 volumio bluetoothd[732]: Adv Monitor app :1.25 disconnected from D-Bus
Feb 10 17:06:20 volumio sudo[1781]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:06:20 volumio sudo[1781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:20 volumio sudo[1781]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:20 volumio sudo[1784]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:06:20 volumio sudo[1784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:20 volumio sudo[1784]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:20 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.27
Feb 10 17:06:20 volumio bluetoothd[732]: Path / reserved for Adv Monitor app :1.28
Feb 10 17:06:20 volumio volumio[1207]: info: MyVolumio token set successfully
Feb 10 17:06:20 volumio volumio[1207]: info: MYVOLUMIO: Adding device
Feb 10 17:06:20 volumio volumio[1207]: info: MYVOLUMIO: Evaluating Server
Feb 10 17:06:20 volumio bluetoothd[732]: Adv Monitor app :1.27 disconnected from D-Bus
Feb 10 17:06:21 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand status took 21 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand status took 3 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info:
Feb 10 17:06:21 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand status took 186 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand status took 186 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 163 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 155 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: info: sendMpdCommand status took 24 milliseconds
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:21 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:21 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:21 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:21 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1260,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:21 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus stop
Feb 10 17:06:21 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:21 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:21 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:21 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1375,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:21 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus play
Feb 10 17:06:21 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:21 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:06:21 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:21 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:21 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:21 volumio volumio[1207]: info: ------------------------------ 391ms
Feb 10 17:06:21 volumio volumio[1207]: info: ------------------------------ 440ms
Feb 10 17:06:21 volumio volumio[1207]: info: Bluetoothremote--- ✅ Reconnected Yandex Remote 2 (54:A9:C8:84:2D:24)
Feb 10 17:06:22 volumio volumio[1207]: info: sendMpdCommand status took 420 milliseconds
Feb 10 17:06:22 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 396 milliseconds
Feb 10 17:06:22 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 393 milliseconds
Feb 10 17:06:22 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 379 milliseconds
Feb 10 17:06:22 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:22 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:22 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:22 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:22 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:22 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:22 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:22 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1375,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:22 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus play
Feb 10 17:06:22 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:22 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:22 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1375,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:22 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus play
Feb 10 17:06:22 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:22 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:22 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1467,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:22 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus play
Feb 10 17:06:22 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:22 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:22 volumio volumio[1207]: info: ------------------------------ 909ms
Feb 10 17:06:22 volumio volumio[1207]: info: ------------------------------ 909ms
Feb 10 17:06:22 volumio volumio[1207]: info: ------------------------------ 774ms
Feb 10 17:06:23 volumio volumio[1207]: info: MyVolumio status changed
Feb 10 17:06:23 volumio volumio[1207]: info: Streaming services startup
Feb 10 17:06:23 volumio volumio[1207]: info: Starting Streaming Daemon
Feb 10 17:06:23 volumio volumio[1207]: info: Removing browser output: myVolumio user plan is not superstar
Feb 10 17:06:23 volumio volumio[1207]: info: Removing audio output:
Feb 10 17:06:23 volumio volumio[1207]: info: Stoppping Tunnel 1
Feb 10 17:06:23 volumio sudo[1810]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 10 17:06:23 volumio sudo[1810]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:23 volumio sudo[1810]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:23 volumio sudo[1812]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Feb 10 17:06:23 volumio sudo[1812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:23 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.
Feb 10 17:06:23 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.
Feb 10 17:06:23 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.
Feb 10 17:06:23 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.
Feb 10 17:06:23 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.
Feb 10 17:06:23 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.
Feb 10 17:06:23 volumio sudo[1812]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 10 17:06:23 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 1675 milliseconds
Feb 10 17:06:23 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:23 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:23 volumio volumio[1207]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1467,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:23 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService play
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus play
Feb 10 17:06:23 volumio volumio[1207]: info: Received an update from plugin. extracting info from payload
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:23 volumio volumio[1207]: info: ------------------------------ 2188ms
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:23 volumio volumio[1207]: info: Setting Geolocation for MyVolumio to eu11
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:23 volumio volumio[1207]: info: Remote SSH Stopped
Feb 10 17:06:23 volumio volumio[1207]: error: Cannot start Volumio Streaming Daemon
Feb 10 17:06:23 volumio volumio[1207]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 10 17:06:23 volumio volumio[1207]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 10 17:06:23 volumio volumio-remote-updater[752]: Test mode disabled
Feb 10 17:06:23 volumio volumio-remote-updater[752]: Alpha mode disabled
Feb 10 17:06:23 volumio volumio-remote-updater[752]: Alpha legacy test mode disabled
Feb 10 17:06:23 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 10 17:06:24 volumio volumio[1207]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for CPU utilization spike
\nFix for triggerhappy input permission
\n
\nNEW ADDITIONS
\n\nAdd BLE onboarding plugin
\nEnable vc4-kms-v3d for all compatible RPi models
\nUpdate Tidal SDK
\n\n","title":"Update v4.096","updateavailable":true}
Feb 10 17:06:24 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 10 17:06:25 volumio volumio[1207]: info: Updating MyVolumio device info
Feb 10 17:06:25 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:25 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:25 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:26 volumio volumio[1207]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Feb 10 17:06:26 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 10 17:06:27 volumio sudo[1824]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:06:27 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:27 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:27 volumio volumio[1207]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Feb 10 17:06:27 volumio sudo[1822]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:06:27 volumio sudo[1822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:27 volumio sudo[1822]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:29 volumio volumio[1207]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Feb 10 17:06:30 volumio volumio[1207]: info: MYVOLUMIO: Adding device
Feb 10 17:06:30 volumio volumio[1207]: info: MYVOLUMIO: Evaluating Server
Feb 10 17:06:31 volumio sudo[1843]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:06:31 volumio sudo[1843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:31 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Feb 10 17:06:31 volumio sudo[1843]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:31 volumio sudo[1845]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:06:31 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:31 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 10 17:06:32 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:06:32 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Feb 10 17:06:33 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:33 volumio volumio[1207]: info: Setting Geolocation for MyVolumio to eu11
Feb 10 17:06:33 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:33 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:33 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:33 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Feb 10 17:06:34 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:34 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:34 volumio volumio[1207]: info: Updating MyVolumio device info
Feb 10 17:06:34 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:34 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:34 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:35 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:35 volumio volumio[1207]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Feb 10 17:06:35 volumio sudo[1872]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 10 17:06:35 volumio sudo[1872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:35 volumio sudo[1872]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:35 volumio sudo[1875]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 10 17:06:35 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 10 17:06:35 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root
Feb 10 17:06:35 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Feb 10 17:06:35 volumio volumio[1207]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 10 17:06:35 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 10 17:06:35 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 10 17:06:35 volumio volumio[1207]: verbose: New Socket.io Connection to 192.168.1.116 from 192.168.1.146 UA: Mozilla/5.0 (Linux; Android 16; V2324A Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 10 17:06:36 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:36 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 10 17:06:36 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:37 volumio volumio[1207]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Feb 10 17:06:37 volumio volumio[1207]: info: Completed starting MyVolumio Plugin
Feb 10 17:06:37 volumio volumio[1207]:  [Metrics]  CommandRouter:  64s 161.35ms 
Feb 10 17:06:37 volumio volumio[1207]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 10 17:06:37 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 10 17:06:37 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 10 17:06:37 volumio volumio[1207]: info: CoreCommandRouter::Close All Modals sent
Feb 10 17:06:37 volumio volumio[1207]: info: CoreCommandRouter::Close All Modals sent
Feb 10 17:06:37 volumio volumio[1207]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Feb 10 17:06:37 volumio volumio[1207]: aplay: main:831: audio open error: Device or resource busy
Feb 10 17:06:38 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 10 17:06:38 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 10 17:06:38 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 10 17:06:39 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioPause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::servicePause
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::servicePause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::pause
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand pause
Feb 10 17:06:43 volumio volumio[1207]: info:
Feb 10 17:06:43 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand pause took 36 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:43 volumio volumio[1207]: info:
Feb 10 17:06:43 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:43 volumio volumio[1207]: info:
Feb 10 17:06:43 volumio volumio[1207]: ---------------------------- MPD announces state update: player
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::getState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand status
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand status took 11 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand status took 28 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand status took 20 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseState
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:43 volumio volumio[1207]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23360,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:43 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer
Feb 10 17:06:43 volumio volumio[1207]: info: ------------------------------ 121ms
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 99 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: info: sendMpdCommand playlistinfo took 99 milliseconds
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:43 volumio volumio[1207]: verbose: ControllerMpd::parseTrackInfo
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:43 volumio volumio[1207]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23360,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:43 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer
Feb 10 17:06:43 volumio volumio[1207]: info: ControllerMpd::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::servicePushState
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getTrack 0
Feb 10 17:06:43 volumio volumio[1207]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23360,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Inner Journey","artist":"Inward Universe","album":"Echoes Of Silence","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-144.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da5f62b6f8fc3b063d30ef90a627738896e5f0a02bb0d23ae9881c10cd6a839fd%2Clid%3D305%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69991e8f%2F0%2F54474%2Fcfda0ff8.206107208.6.141196287%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 10 17:06:43 volumio volumio[1207]: verbose: CURRENT POSITION 0
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   stateService pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::syncState   currentStatus pause
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::pushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioPushState
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::stPlaybackTimer
Feb 10 17:06:43 volumio volumio[1207]: info: ------------------------------ 246ms
Feb 10 17:06:43 volumio volumio[1207]: info: ------------------------------ 237ms
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:43 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:44 volumio volumio[1207]: info: BOOT COMPLETED
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 10 17:06:45 volumio volumio[1207]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 10 17:06:45 volumio volumio[1207]: info: Received Get System Version
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:06:45 volumio volumio[1207]: info: Received Get System Info
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:06:45 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:45 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:06:49 volumio volumio[1207]: info: CoreCommandRouter::volumioGetQueue
Feb 10 17:06:49 volumio volumio[1207]: info: CoreStateMachine::getQueue
Feb 10 17:06:49 volumio volumio[1207]: info: CorePlayQueue::getQueue
Feb 10 17:06:49 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:49 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:49 volumio volumio[1207]: info: Listing playlists
Feb 10 17:06:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 10 17:06:51 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 10 17:06:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 10 17:06:52 volumio volumio[1207]: info: Received Get System Info
Feb 10 17:06:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:06:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:06:52 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:06:52 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:52 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 10 17:06:53 volumio volumio[1207]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 10 17:06:53 volumio volumio[1207]: info: Received Get System Version
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 10 17:06:53 volumio volumio[1207]: info: Received Get System Info
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 10 17:06:53 volumio volumio[1207]: info: Discovery: Getting this device information
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::volumioGetState
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 10 17:06:53 volumio volumio[1207]: info: Enabling plugin yandex_music
Feb 10 17:06:53 volumio volumio[1207]: info: Loading plugin "yandex_music"...
Feb 10 17:06:53 volumio volumio[1207]: info: Applying required configuration parameters for plugin yandex_music
Feb 10 17:06:53 volumio volumio[1207]: info: PLUGIN START: yandex_music
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 10 17:06:53 volumio volumio[1207]: info: [1770732413573] CoreMusicLibrary::Adding element Yandex Music
Feb 10 17:06:53 volumio volumio[1207]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 10 17:06:53 volumio volumio[1207]: Cannot find translation for source Yandex Music
Feb 10 17:06:53 volumio volumio[1207]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 10 17:06:53 volumio volumio[1207]: Error: listen EADDRINUSE: address already in use :::6601
Feb 10 17:06:53 volumio volumio[1207]:     at Server.setupListenHandle [as _listen2] (node:net:1872:16)
Feb 10 17:06:53 volumio volumio[1207]:     at listenInCluster (node:net:1920:12)
Feb 10 17:06:53 volumio volumio[1207]:     at Server.listen (node:net:2008:7)
Feb 10 17:06:53 volumio volumio[1207]:     at Proxy.start (/data/plugins/music_service/yandex_music/proxy.js:109:17)
Feb 10 17:06:53 volumio volumio[1207]:     at yandexMusic.onStart (/data/plugins/music_service/yandex_music/index.js:64:20)
Feb 10 17:06:53 volumio volumio[1207]:     at PluginManager.startPlugin (/volumio/app/pluginmanager.js:431:30)
Feb 10 17:06:53 volumio volumio[1207]:     at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Feb 10 17:06:53 volumio volumio[1207]:     at process.processTicksAndRejections (node:internal/process/task_queues:77:11) {
Feb 10 17:06:53 volumio volumio[1207]:   code: 'EADDRINUSE',
Feb 10 17:06:53 volumio volumio[1207]:   errno: -98,
Feb 10 17:06:53 volumio volumio[1207]:   syscall: 'listen',
Feb 10 17:06:53 volumio volumio[1207]:   address: '::',
Feb 10 17:06:53 volumio volumio[1207]:   port: 6601
Feb 10 17:06:53 volumio volumio[1207]: }
Feb 10 17:06:53 volumio volumio[1207]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 10 17:06:56 volumio sudo[1940]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-10 17:05'
Feb 10 17:06:56 volumio sudo[1940]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025"
VOLUMIO_VERSION="4.084"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"