-- Logs begin at Mon 2024-12-16 09:35:29 CET, end at Tue 2025-02-25 14:41:39 CET. --
Feb 25 14:40:19 volumio2 systemd-timedated[985]: Changed local time to Tue Feb 25 14:40:19 2025
Feb 25 14:40:19 volumio2 sudo[980]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:19 volumio2 volumio-time-update[582]: volumio-time-update-util: System time updated successfully.
Feb 25 14:40:19 volumio2 wireless.js[613]: trying...
Feb 25 14:40:19 volumio2 systemd[1]: Starting Daily apt download activities...
Feb 25 14:40:19 volumio2 systemd[1]: Started Volumio Time Update Utility.
Feb 25 14:40:19 volumio2 sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:19 volumio2 sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:19 volumio2 sudo[990]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:20 volumio2 wireless.js[613]: trying...
Feb 25 14:40:20 volumio2 sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:20 volumio2 sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:20 volumio2 sudo[1012]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:20 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:20] [info] asio async_connect error: system:111 (Connection refused)
Feb 25 14:40:20 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 25 14:40:20 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:20] [error] handle_connect error: Underlying Transport Error
Feb 25 14:40:21 volumio2 wireless.js[613]: trying...
Feb 25 14:40:21 volumio2 sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:21 volumio2 sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:21 volumio2 sudo[1015]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:22 volumio2 wireless.js[613]: trying...
Feb 25 14:40:22 volumio2 sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:22 volumio2 sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:22 volumio2 sudo[1018]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:23 volumio2 wireless.js[613]: trying...
Feb 25 14:40:23 volumio2 sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:23 volumio2 sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:23 volumio2 sudo[1028]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:23 volumio2 systemd[1]: apt-daily.service: Succeeded.
Feb 25 14:40:23 volumio2 systemd[1]: Started Daily apt download activities.
Feb 25 14:40:23 volumio2 systemd[1]: Starting Daily apt upgrade and clean activities...
Feb 25 14:40:24 volumio2 wpa_supplicant[922]: wlan0: Trying to associate with SSID 'SurveillanceVan'
Feb 25 14:40:24 volumio2 wireless.js[613]: trying...
Feb 25 14:40:24 volumio2 sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:24 volumio2 sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:24 volumio2 sudo[1072]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: carrier acquired
Feb 25 14:40:24 volumio2 wpa_supplicant[922]: wlan0: Associated with b8:ec:a3:f2:f9:12
Feb 25 14:40:24 volumio2 wpa_supplicant[922]: wlan0: CTRL-EVENT-CONNECTED - Connection to b8:ec:a3:f2:f9:12 completed [id=0 id_str=]
Feb 25 14:40:24 volumio2 wpa_supplicant[922]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: connected to Access Point `SurveillanceVan'
Feb 25 14:40:24 volumio2 wpa_supplicant[922]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: IAID eb:eb:63:fa
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: adding address fe80::4774:bf4d:91ad:ec72
Feb 25 14:40:24 volumio2 dhcpcd[970]: ipv6_addaddr1: Permission denied
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: carrier lost
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: carrier acquired
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: IAID eb:eb:63:fa
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: rebinding lease of 192.168.1.173
Feb 25 14:40:24 volumio2 dhcpcd[970]: wlan0: probing address 192.168.1.173/24
Feb 25 14:40:25 volumio2 wireless.js[613]: trying...
Feb 25 14:40:25 volumio2 sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:25 volumio2 sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:25 volumio2 dhcpcd[970]: wlan0: soliciting an IPv6 router
Feb 25 14:40:25 volumio2 sudo[1097]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:26 volumio2 wireless.js[613]: trying...
Feb 25 14:40:26 volumio2 sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:26 volumio2 sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:26 volumio2 sudo[1102]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:26 volumio2 systemd[1]: apt-daily-upgrade.service: Succeeded.
Feb 25 14:40:26 volumio2 systemd[1]: Started Daily apt upgrade and clean activities.
Feb 25 14:40:27 volumio2 wireless.js[613]: trying...
Feb 25 14:40:27 volumio2 sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:27 volumio2 sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:27 volumio2 sudo[1135]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:28 volumio2 wireless.js[613]: trying...
Feb 25 14:40:28 volumio2 sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:28 volumio2 sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:28 volumio2 sudo[1138]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:29 volumio2 wireless.js[613]: trying...
Feb 25 14:40:29 volumio2 sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:29 volumio2 sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:29 volumio2 sudo[1141]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:29 volumio2 dhcpcd[970]: wlan0: leased 192.168.1.173 for 86400 seconds
Feb 25 14:40:29 volumio2 avahi-daemon[615]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.173.
Feb 25 14:40:29 volumio2 dhcpcd[970]: wlan0: adding route to 192.168.1.0/24
Feb 25 14:40:29 volumio2 dhcpcd[970]: wlan0: adding default route via 192.168.1.1
Feb 25 14:40:29 volumio2 avahi-daemon[615]: New relevant interface wlan0.IPv4 for mDNS.
Feb 25 14:40:29 volumio2 avahi-daemon[615]: Registering new address record for 192.168.1.173 on wlan0.IPv4.
Feb 25 14:40:30 volumio2 wireless.js[613]: trying...
Feb 25 14:40:30 volumio2 sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 25 14:40:30 volumio2 sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:30 volumio2 sudo[1165]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:30 volumio2 wireless.js[613]: Connected to: ----SurveillanceVan
Feb 25 14:40:30 volumio2 wireless.js[613]: ----
Feb 25 14:40:30 volumio2 sudo[1168]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:40:30 volumio2 sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:30 volumio2 sudo[1168]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:30 volumio2 wireless.js[613]: ... joined AP, wlan0 IPv4 is 192.168.1.173, ipV6 is undefined
Feb 25 14:40:30 volumio2 wireless.js[613]: It's done! AP
Feb 25 14:40:30 volumio2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Feb 25 14:40:30 volumio2 systemd[1]: Started Wireless Services.
Feb 25 14:40:30 volumio2 systemd[1]: Started Volumio Backend Module.
Feb 25 14:40:30 volumio2 systemd[1]: Started Volumio Cpu Tweaker.
Feb 25 14:40:30 volumio2 systemd[1]: Reached target Multi-User System.
Feb 25 14:40:30 volumio2 systemd[1]: Reached target Graphical Interface.
Feb 25 14:40:30 volumio2 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: Setting RT Priority for mpd
Feb 25 14:40:30 volumio2 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Feb 25 14:40:30 volumio2 systemd[1]: Started Update UTMP about System Runlevel Changes.
Feb 25 14:40:30 volumio2 systemd[1]: Startup finished in 14.974s (kernel) + 31.322s (userspace) = 46.296s.
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: Setting MPD Affinity
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: pid 797's current affinity mask: f
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: pid 797's new affinity mask: 3
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Feb 25 14:40:30 volumio2 volumio-cpu-tweak[1174]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Feb 25 14:40:30 volumio2 systemd[1]: volumio_cpu_tweak.service: Succeeded.
Feb 25 14:40:30 volumio2 ntpd[751]: Listen normally on 4 wlan0 192.168.1.173:123
Feb 25 14:40:30 volumio2 ntpd[751]: new interface(s) found: waking up resolver
Feb 25 14:40:30 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:30] [info] asio async_connect error: system:111 (Connection refused)
Feb 25 14:40:30 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:30] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 25 14:40:30 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:30] [error] handle_connect error: Underlying Transport Error
Feb 25 14:40:34 volumio2 systemd[1]: systemd-fsckd.service: Succeeded.
Feb 25 14:40:35 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:35 volumio2 volumio[1173]: info: ----- Volumio3 ----
Feb 25 14:40:35 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:35 volumio2 volumio[1173]: info: ----- System startup ----
Feb 25 14:40:35 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:37 volumio2 volumio[1173]: info: MYVOLUMIO Environment detected
Feb 25 14:40:37 volumio2 volumio[1173]: info: Plugin folders cleanup
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning into folder /volumio/app/plugins/
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category audio_interface
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category miscellanea
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category music_service
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category plugins.json
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category system_controller
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category user_interface
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning into folder /data/plugins/
Feb 25 14:40:37 volumio2 volumio[1173]: info: Scanning category audio_interface
Feb 25 14:40:37 volumio2 volumio[1173]: info: Plugin folders cleanup completed
Feb 25 14:40:37 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:37 volumio2 volumio[1173]: info: ----- Core plugins startup ----
Feb 25 14:40:37 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:37 volumio2 volumio[1173]: info: Loading plugins from folder /volumio/app/plugins/
Feb 25 14:40:37 volumio2 volumio[1173]: info: Adding plugin upnp to MyMusic Plugins
Feb 25 14:40:37 volumio2 volumio[1173]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 25 14:40:37 volumio2 volumio[1173]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 25 14:40:37 volumio2 volumio[1173]: info: Loading plugins from folder /data/plugins/
Feb 25 14:40:37 volumio2 volumio[1173]: info: Loading plugin "system"...
Feb 25 14:40:37 volumio2 volumio[1173]: info: Loading plugin "appearance"...
Feb 25 14:40:40 volumio2 volumio[1173]: info: Loading plugin "network"...
Feb 25 14:40:40 volumio2 volumio[1173]: info: Refreshing Cached IP Addresses
Feb 25 14:40:40 volumio2 sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:40:40 volumio2 sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:40 volumio2 sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:40:40 volumio2 sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:40 volumio2 sudo[1208]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:40 volumio2 sudo[1210]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:40 volumio2 volumio[1173]: info: Loading plugin "services"...
Feb 25 14:40:40 volumio2 volumio[1173]: info: Loading plugin "alsa_controller"...
Feb 25 14:40:40 volumio2 sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 25 14:40:40 volumio2 sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:40 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:40:40 volumio2 volumio[1173]: info: Loading plugin "wizard"...
Feb 25 14:40:40 volumio2 volumio[1173]: info: Loading plugin "networkfs"...
Feb 25 14:40:40 volumio2 volumio[1173]: info: Starting Udev Watcher for removable devices
Feb 25 14:40:40 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:40] [connect] Successful connection
Feb 25 14:40:40 volumio2 volumio[1173]: info: Ignoring mount for partition: boot
Feb 25 14:40:40 volumio2 volumio[1173]: info: Ignoring mount for partition: volumio
Feb 25 14:40:40 volumio2 volumio[1173]: info: Ignoring mount for partition: volumio_data
Feb 25 14:40:40 volumio2 volumio[1173]: info: Mounting Device Backup
Feb 25 14:40:40 volumio2 sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Backup -o noatime
Feb 25 14:40:40 volumio2 sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:41 volumio2 systemd[1]: systemd-hostnamed.service: Succeeded.
Feb 25 14:40:41 volumio2 mount.exfat[1243]: volume was not unmounted cleanly
Feb 25 14:40:41 volumio2 sudo[1241]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:41 volumio2 volumio[1173]: WARN: volume was not unmounted cleanly.
Feb 25 14:40:41 volumio2 volumio[1173]: info: Mounting Device Musik2
Feb 25 14:40:41 volumio2 sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Musik2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 25 14:40:41 volumio2 sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:42 volumio2 ntfs-3g[1257]: Version 2017.3.23AR.3 integrated FUSE 28
Feb 25 14:40:42 volumio2 ntfs-3g[1257]: Mounted /dev/sda1 (Read-Write, label "Musik2", NTFS 3.1)
Feb 25 14:40:42 volumio2 ntfs-3g[1257]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 25 14:40:42 volumio2 ntfs-3g[1257]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096
Feb 25 14:40:42 volumio2 ntfs-3g[1257]: Global ownership and permissions enforced, configuration type 7
Feb 25 14:40:42 volumio2 sudo[1254]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:42 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 25 14:40:42 volumio2 volumio[1173]: info: Loading plugin "volumio_command_line_client"...
Feb 25 14:40:42 volumio2 volumio[1173]: info: Loading plugin "upnp"...
Feb 25 14:40:42 volumio2 volumio[1173]: info: [1740490842872] Starting Upmpd Daemon
Feb 25 14:40:42 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 25 14:40:42 volumio2 volumio[1173]: info: Loading plugin "my_music"...
Feb 25 14:40:42 volumio2 volumio[1173]: info: Loading plugin "mpd"...
Feb 25 14:40:43 volumio2 volumio[1173]: info: Loading plugin "upnp_browser"...
Feb 25 14:40:44 volumio2 volumio[1173]: info: Loading plugin "alarm-clock"...
Feb 25 14:40:44 volumio2 sudo[1219]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:44 volumio2 volumio[1173]: info: Loading plugin "airplay_emulation"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "last_100"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "webradio"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "i2s_dacs"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: I2S DAC not set, start Auto-detection
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "volumiodiscovery"...
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** For more information see
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 25 14:40:45 volumio2 volumio[1173]: *** WARNING *** For more information see
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** For more information see
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 25 14:40:45 volumio2 node[1173]: *** WARNING *** For more information see
Feb 25 14:40:45 volumio2 volumio[1173]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 25 14:40:45 volumio2 volumio[1173]: info: Discovery: Started advertising with name: Volumio2
Feb 25 14:40:45 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "outputs"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "albumart"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Plugin example_plugin is not enabled
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "inputs"...
Feb 25 14:40:45 volumio2 volumio[1173]: info: Loading plugin "updater_comm"...
Feb 25 14:40:46 volumio2 volumio[1173]: info: Plugin mpdemulation is not enabled
Feb 25 14:40:46 volumio2 volumio[1173]: info: Loading plugin "rest_api"...
Feb 25 14:40:46 volumio2 volumio[1173]: info: Loading plugin "websocket"...
Feb 25 14:40:46 volumio2 volumio[1173]: info: Starting Socket.io Server version 2.3.0
Feb 25 14:40:46 volumio2 volumio[1173]: info: Plugin fusiondsp is not enabled
Feb 25 14:40:46 volumio2 volumio[1173]: info: Loading i18n strings for locale sv
Feb 25 14:40:46 volumio2 volumio[1173]: Updating browse sources language
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:40:46 volumio2 volumio[1173]: Forking 3 albumart workers
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::initPlayerControls
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 14:40:46 volumio2 volumio[1173]: Express server listening on port 3000
Feb 25 14:40:46 volumio2 volumio[1173]: [Metrics] WebUI: 13s 377.71ms
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreStateMachine::resetVolumioState
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreStateMachine::getcurrentVolume
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::volumioRetrievevolume
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:47 volumio2 volumio[1173]: info: Scanning new location : "USB/Backup"
Feb 25 14:40:47 volumio2 volumio[1173]: info: Scanning new location : "USB/Musik2"
Feb 25 14:40:47 volumio2 volumio[1173]: info: Volumio Network Manager: Network status updated: 3
Feb 25 14:40:47 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236:3000 from 192.168.1.14 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Feb 25 14:40:47 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236:3000 from 192.168.1.14 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Feb 25 14:40:47 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236:3000 from 192.168.1.14 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Feb 25 14:40:47 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236:3000 from 192.168.1.14 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:40:47 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:47 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:47 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:40:48 volumio2 volumio[1173]: info: Reloading queue from file
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Feb 25 14:40:48 volumio2 volumio[1173]: info: VolumeController:: Volume=100 Mute =false
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::updateTrackBlock
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrackBlock
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioRetrievevolume
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::setRepeat null single undefined
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::setRandom null
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: Setting Device type: Raspberry PI
Feb 25 14:40:48 volumio2 volumio[1173]: Starting albumart workers
Feb 25 14:40:48 volumio2 volumio[1173]: Starting albumart workers
Feb 25 14:40:48 volumio2 volumio[1173]: Starting albumart workers
Feb 25 14:40:48 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236:3000 from 192.168.1.171 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: Discovery: adding 214bf2a5-a2d1-48f0-b12a-7d0b1880b832
Feb 25 14:40:48 volumio2 volumio[1173]: info: Discovery: Found device Volumio1
Feb 25 14:40:48 volumio2 volumio[1173]: info: Discovery: Connecting to remote: 192.168.1.15
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 14:40:48 volumio2 volumio[1173]: info: VolumeController:: Volume=100 Mute =false
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:48 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:40:48 volumio2 volumio[1173]: info: Discovery: this is already registered, 214bf2a5-a2d1-48f0-b12a-7d0b1880b832
Feb 25 14:40:48 volumio2 volumio[1173]: info: Discovery: Found device Volumio1
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: Connecting to remote: 192.168.1.15
Feb 25 14:40:49 volumio2 systemd[1]: systemd-timedated.service: Succeeded.
Feb 25 14:40:49 volumio2 volumio[1173]: info: Completed loading Core Plugins
Feb 25 14:40:49 volumio2 volumio[1173]: info: Preparing to generate the ALSA configuration file
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: adding 5e57e6a6-d492-433b-9cc9-2b8ca60ce50f
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: Found device Volumio2
Feb 25 14:40:49 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:49 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: this is already registered, 5e57e6a6-d492-433b-9cc9-2b8ca60ce50f
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: Found device Volumio2
Feb 25 14:40:49 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:49 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:49 volumio2 volumio[1173]: info: Discovery: Connected to remote: 192.168.1.15
Feb 25 14:40:49 volumio2 volumio[1173]: info: Asound.conf file written
Feb 25 14:40:49 volumio2 sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 25 14:40:49 volumio2 sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:49 volumio2 sudo[1314]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:49 volumio2 volumio[1173]: info: Output device has changed, restarting MPD
Feb 25 14:40:49 volumio2 volumio[1173]: info: Output device has changed, restarting Shairport Sync
Feb 25 14:40:49 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:49 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:49 volumio2 sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 25 14:40:49 volumio2 sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:49 volumio2 sudo[1327]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:49 volumio2 sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 25 14:40:49 volumio2 sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:50 volumio2 systemd[1]: Stopping Music Player Daemon...
Feb 25 14:40:50 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:40:50 volumio2 volumio[1173]: info: ___________ START PLUGINS ___________
Feb 25 14:40:50 volumio2 volumio[1173]: info: ControllerMpd::onStart: Initializing MPD
Feb 25 14:40:50 volumio2 volumio[1173]: info: Creating MPD Configuration file
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 25 14:40:50 volumio2 volumio[1173]: info: [1740490850139] CoreMusicLibrary::Adding element Mediaservrar
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:40:50 volumio2 sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 25 14:40:50 volumio2 sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:50 volumio2 sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 25 14:40:50 volumio2 sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:50 volumio2 sudo[1344]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:50 volumio2 systemd[1]: mpd.service: Succeeded.
Feb 25 14:40:50 volumio2 systemd[1]: Stopped Music Player Daemon.
Feb 25 14:40:50 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:50 volumio2 systemd[1]: Starting Music Player Daemon...
Feb 25 14:40:50 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 25 14:40:50 volumio2 volumio[1173]: info: [1740490850462] CoreMusicLibrary::Adding element Last_100
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 25 14:40:50 volumio2 volumio[1173]: info: [1740490850469] CoreMusicLibrary::Adding element Webradio
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:40:50 volumio2 volumio[1173]: info: Initializing BBC Radios
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:40:50 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:50 volumio2 volumio[1173]: info: Volumio Calling Home
Feb 25 14:40:50 volumio2 sudo[1360]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 25 14:40:50 volumio2 sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:50 volumio2 sudo[1360]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:51 volumio2 volumio[1173]: info: MPD Permissions set
Feb 25 14:40:51 volumio2 volumio[1173]: info: MPD Permissions set
Feb 25 14:40:51 volumio2 volumio[1173]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:40:51 volumio2 volumio[1173]: info: Volumio called home
Feb 25 14:40:51 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:40:51 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:40:51 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:40:51 volumio2 sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:40:51 volumio2 sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:51 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:51 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:51 volumio2 sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:40:51 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 25 14:40:51 volumio2 sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:51 volumio2 systemd[1]: shairport-sync.service: Succeeded.
Feb 25 14:40:51 volumio2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:40:51 volumio2 sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:40:51 volumio2 sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:51 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:40:51 volumio2 sudo[1402]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:51 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 25 14:40:51 volumio2 systemd[1]: shairport-sync.service: Succeeded.
Feb 25 14:40:51 volumio2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:40:51 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:40:51 volumio2 sudo[1407]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:51 volumio2 sudo[1404]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:51 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:40:51 volumio2 volumio[1173]: Error adding Membership: Error: addMembership EINVAL
Feb 25 14:40:51 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:40:51 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:40:52 volumio2 sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:40:52 volumio2 sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:52 volumio2 sudo[1417]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:52 volumio2 sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:40:52 volumio2 sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:52 volumio2 sudo[1419]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:52 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236 from 192.168.1.171 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Feb 25 14:40:52 volumio2 sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:40:52 volumio2 sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:52 volumio2 sudo[1423]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:52 volumio2 sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:40:52 volumio2 sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:52 volumio2 sudo[1425]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:52 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 25 14:40:52 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:53 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 14:40:53 volumio2 sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 25 14:40:53 volumio2 sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:53 volumio2 systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 25 14:40:53 volumio2 sudo[1429]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:53 volumio2 volumio[1173]: info: Upmpdcli Daemon Started
Feb 25 14:40:53 volumio2 sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:40:53 volumio2 sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:53 volumio2 sudo[1433]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:53 volumio2 sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:40:53 volumio2 sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:40:53 volumio2 sudo[1435]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:53 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236 from 192.168.1.171 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:53 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:53 volumio2 mpd[1391]: Feb 25 14:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 25 14:40:53 volumio2 systemd[1]: Started Music Player Daemon.
Feb 25 14:40:53 volumio2 sudo[1346]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:53 volumio2 sudo[1329]: pam_unix(sudo:session): session closed for user root
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 25 14:40:53 volumio2 volumio[1173]: info: Listing playlists
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 14:40:53 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 14:40:53 volumio2 volumio[1173]: info: Completed starting Core Plugins
Feb 25 14:40:53 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:53 volumio2 volumio[1173]: info: ----- MyVolumio plugins startup ----
Feb 25 14:40:53 volumio2 volumio[1173]: info: -------------------------------------------
Feb 25 14:40:53 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 25 14:40:53 volumio2 volumio[1173]: error: MPD error: The expression evaluated to a falsy value:
Feb 25 14:40:53 volumio2 volumio[1173]: assert.ok(self.idling)
Feb 25 14:40:53 volumio2 volumio[1173]: error: The expression evaluated to a falsy value:
Feb 25 14:40:53 volumio2 volumio[1173]: assert.ok(self.idling)
Feb 25 14:40:54 volumio2 volumio[1173]: info: MPD running with PID1391
Feb 25 14:40:54 volumio2 volumio[1173]: ,establishing connection
Feb 25 14:40:54 volumio2 volumio[1173]: error: updateQueue error: null
Feb 25 14:40:54 volumio2 volumio[1173]: error: updateQueue error: null
Feb 25 14:40:54 volumio2 volumio[1431]: Generating RSA private key, 4096 bit long modulus (2 primes)
Feb 25 14:40:55 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 14:40:55 volumio2 volumio[1173]: info: Received Get System Info
Feb 25 14:40:55 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:40:55 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:40:55 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:40:55 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:55 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:55 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:40:55 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:55] [connect] Successful connection
Feb 25 14:40:55 volumio2 volumio-remote-updater[576]: [2025-02-25 14:40:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740490855 101
Feb 25 14:40:55 volumio2 volumio[1173]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 14:40:56 volumio2 volumio[1173]: info: Received Get System Info
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:40:56 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:40:56 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:40:56 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:40:57 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Feb 25 14:41:01 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetQueue
Feb 25 14:41:01 volumio2 volumio[1173]: info: CoreStateMachine::getQueue
Feb 25 14:41:01 volumio2 volumio[1173]: info: CorePlayQueue::getQueue
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin bluetooth to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin multiroom to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin metavolumio to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin cd_controller to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin smart_inputs to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: Adding plugin tidalconnect to MyMusic Plugins
Feb 25 14:41:02 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Feb 25 14:41:04 volumio2 volumio[1173]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Feb 25 14:41:04 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Feb 25 14:41:04 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:04 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:04 volumio2 volumio[1173]: info: Starting MyVolumio Remote Streaming Endpoints
Feb 25 14:41:05 volumio2 volumio[1173]: info: MyVolumio login type: Token
Feb 25 14:41:05 volumio2 volumio[1173]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Feb 25 14:41:05 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Feb 25 14:41:07 volumio2 volumio[1173]: info: Starting Streaming Service Transparent Proxy
Feb 25 14:41:07 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 25 14:41:07 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 25 14:41:07 volumio2 volumio[1173]: info: Streaming services startup
Feb 25 14:41:07 volumio2 volumio[1173]: info: Starting Streaming Daemon
Feb 25 14:41:07 volumio2 sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 25 14:41:07 volumio2 sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:07 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 25 14:41:07 volumio2 sudo[1484]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:07 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 14:41:08 volumio2 volumio[1173]: error: Cannot start Volumio Streaming Daemon
Feb 25 14:41:08 volumio2 volumio[1173]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 25 14:41:08 volumio2 volumio[1173]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 25 14:41:08 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:41:08 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:41:08 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:41:08 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:08 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:08 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:41:09 volumio2 volumio[1173]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Feb 25 14:41:09 volumio2 volumio[1431]: .............................................................++++
Feb 25 14:41:09 volumio2 volumio[1173]: STREAMING PROXY: Starting server on port 3245
Feb 25 14:41:09 volumio2 volumio[1173]: Node JS runtime: 14
Feb 25 14:41:10 volumio2 volumio[1173]: info: MyVolumio token set successfully
Feb 25 14:41:10 volumio2 volumio[1173]: info: MYVOLUMIO: Adding device
Feb 25 14:41:10 volumio2 volumio[1173]: info: MYVOLUMIO: Evaluating Server
Feb 25 14:41:10 volumio2 volumio[1173]: info: MyVolumio Plan changed: premium
Feb 25 14:41:10 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Feb 25 14:41:10 volumio2 volumio[1173]: info: Removing browser output: myVolumio user plan is not superstar
Feb 25 14:41:10 volumio2 volumio[1173]: info: Removing audio output:
Feb 25 14:41:10 volumio2 volumio[1173]: info: MYVOLUMIO: Adding device
Feb 25 14:41:10 volumio2 volumio[1173]: info: MYVOLUMIO: Evaluating Server
Feb 25 14:41:10 volumio2 volumio[1173]: info: Remote config written successfully
Feb 25 14:41:10 volumio2 volumio[1173]: info: Starting Tunnel 1
Feb 25 14:41:10 volumio2 volumio[1173]: info: Starting Tunnel Connection Checker
Feb 25 14:41:10 volumio2 volumio[1173]: info: Completed starting MyVolumio Plugin
Feb 25 14:41:11 volumio2 volumio[1173]: info: MYVolumio Device enabled
Feb 25 14:41:11 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Feb 25 14:41:11 volumio2 volumio[1173]: info: MyVolumio status changed
Feb 25 14:41:11 volumio2 volumio[1173]: info: Streaming services startup
Feb 25 14:41:11 volumio2 volumio[1173]: info: Starting Streaming Daemon
Feb 25 14:41:11 volumio2 sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 25 14:41:11 volumio2 sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:11 volumio2 volumio[1173]: info: Setting Geolocation for MyVolumio to eu10
Feb 25 14:41:11 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:11 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:11 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:11 volumio2 sudo[1577]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:11 volumio2 volumio[1173]: error: Cannot start Volumio Streaming Daemon
Feb 25 14:41:11 volumio2 volumio[1173]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 25 14:41:11 volumio2 volumio[1173]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 25 14:41:11 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Feb 25 14:41:11 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Feb 25 14:41:11 volumio2 volumio[1173]: info: [1740490871973] Starting BluetoothController
Feb 25 14:41:12 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Feb 25 14:41:15 volumio2 sudo[1580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Feb 25 14:41:15 volumio2 sudo[1580]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:15 volumio2 sudo[1580]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:15 volumio2 volumio[1173]: info: MRS: MultiRoom plugin initialized
Feb 25 14:41:15 volumio2 volumio[1173]: info: MRS: STOPPING SNAPCLIENT
Feb 25 14:41:15 volumio2 volumio[1173]: info: MRS: Snap server stop
Feb 25 14:41:15 volumio2 sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Feb 25 14:41:15 volumio2 volumio[1173]: info: MRS: STOPPING volumioStreaming
Feb 25 14:41:15 volumio2 sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:15 volumio2 sudo[1598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Feb 25 14:41:15 volumio2 sudo[1598]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Feb 25 14:41:15 volumio2 sudo[1601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Feb 25 14:41:15 volumio2 sudo[1601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:15 volumio2 sudo[1596]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:15 volumio2 sudo[1604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 25 14:41:15 volumio2 sudo[1604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Feb 25 14:41:15 volumio2 sudo[1598]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:15 volumio2 sudo[1604]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Feb 25 14:41:15 volumio2 sudo[1601]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:15 volumio2 ntpd[751]: Soliciting pool server 193.182.111.13
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Feb 25 14:41:15 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Feb 25 14:41:16 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Feb 25 14:41:16 volumio2 volumio[1173]: info: Preparing to generate the ALSA configuration file
Feb 25 14:41:16 volumio2 volumio[1173]: info: Updating MyVolumio device info
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:16 volumio2 sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:41:16 volumio2 sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:16 volumio2 volumio[1173]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 25 14:41:16 volumio2 volumio[1173]: info: Reading ALSA contributions from plugins.
Feb 25 14:41:16 volumio2 sudo[1608]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:16 volumio2 sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:41:16 volumio2 volumio[1173]: info: Setting Geolocation for MyVolumio to eu9
Feb 25 14:41:16 volumio2 sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:16 volumio2 sudo[1610]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 14:41:16 volumio2 volumio[1173]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 25 14:41:16 volumio2 volumio[1173]: info: Received Get System Version
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:41:16 volumio2 volumio[1173]: info: Received Get System Info
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:41:16 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:16 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:41:16 volumio2 volumio[1173]: info: MRS: Removed streaming files
Feb 25 14:41:16 volumio2 volumio[1173]: info: MRS: volumioStreaming STOPPED
Feb 25 14:41:16 volumio2 volumio[1173]: info: MRS: SNAPSERVER STOPPED
Feb 25 14:41:16 volumio2 volumio[1173]: info: MRS: SNAPCLIENT STOPPED
Feb 25 14:41:16 volumio2 ntpd[751]: Soliciting pool server 150.241.82.187
Feb 25 14:41:16 volumio2 sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Feb 25 14:41:16 volumio2 sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:16 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.173 from 192.168.1.171 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Feb 25 14:41:16 volumio2 sudo[1623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:41:16 volumio2 sudo[1623]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:16 volumio2 sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:41:16 volumio2 sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:16 volumio2 sudo[1623]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:16 volumio2 sudo[1626]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:16 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:16 volumio2 systemd[1]: Started MyVolumio SSH Tunnel.
Feb 25 14:41:16 volumio2 sudo[1621]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 25 14:41:16 volumio2 volumio[1173]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 25 14:41:16 volumio2 volumio[1173]: info: Listing playlists
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetQueue
Feb 25 14:41:16 volumio2 volumio[1173]: info: CoreStateMachine::getQueue
Feb 25 14:41:16 volumio2 volumio[1173]: info: CorePlayQueue::getQueue
Feb 25 14:41:16 volumio2 autossh[1630]: port set to 0, monitoring disabled
Feb 25 14:41:16 volumio2 autossh[1630]: starting ssh (count 1)
Feb 25 14:41:16 volumio2 autossh[1630]: ssh child pid is 1633
Feb 25 14:41:16 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.173 from 192.168.1.171 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Feb 25 14:41:16 volumio2 volumio[1173]: info: Remote SSH Started
Feb 25 14:41:17 volumio2 volumiossh-tunnel[1629]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts.
Feb 25 14:41:17 volumio2 volumio[1173]: info: Asound.conf file written
Feb 25 14:41:17 volumio2 sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 25 14:41:17 volumio2 sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:17 volumio2 sudo[1635]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:17 volumio2 volumio[1173]: info: Output device has changed, restarting MPD
Feb 25 14:41:17 volumio2 volumio[1173]: info: Output device has changed, restarting Shairport Sync
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:17 volumio2 sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 25 14:41:17 volumio2 sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:17 volumio2 sudo[1640]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:17 volumio2 sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 25 14:41:17 volumio2 sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:17 volumio2 ntpd[751]: Soliciting pool server 162.159.200.1
Feb 25 14:41:17 volumio2 systemd[1]: Stopping Music Player Daemon...
Feb 25 14:41:17 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:41:17 volumio2 volumio[1173]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:17 volumio2 volumio[1431]: ............................++++
Feb 25 14:41:17 volumio2 systemd[1]: mpd.service: Succeeded.
Feb 25 14:41:17 volumio2 volumio[1431]: e is 65537 (0x010001)
Feb 25 14:41:17 volumio2 systemd[1]: Stopped Music Player Daemon.
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 25 14:41:17 volumio2 volumio[1431]: writing RSA key
Feb 25 14:41:17 volumio2 systemd[1]: Starting Music Player Daemon...
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Feb 25 14:41:17 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output for this device
Feb 25 14:41:17 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output
Feb 25 14:41:17 volumio2 ntpd[751]: Soliciting pool server 192.121.108.99
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:17 volumio2 sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio2
Feb 25 14:41:17 volumio2 volumio[1173]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:17 volumio2 sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:17 volumio2 sudo[1656]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding METAVOLUMIO REST API Endpoints
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Feb 25 14:41:17 volumio2 volumio[1173]: info: Preparing CD Folders
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding CD REST API Endpoints
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Feb 25 14:41:17 volumio2 volumio[1173]: info: Starting UDEV Watcher for CD
Feb 25 14:41:17 volumio2 volumio[1173]: info: Detecting CD presence with UDEV
Feb 25 14:41:17 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Feb 25 14:41:17 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Feb 25 14:41:17 volumio2 volumio[1173]: info: Adding inputs REST Endpoints
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Feb 25 14:41:18 volumio2 volumio[1173]: info: Scanning Audio Inputs
Feb 25 14:41:18 volumio2 sudo[1651]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 25 14:41:18 volumio2 sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:18 volumio2 sudo[1651]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:18 volumio2 volumio[1173]: info: Checking against Known Cards name
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding Server instance for streaming
Feb 25 14:41:18 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Feb 25 14:41:18 volumio2 volumio[1173]: error: Hi Res Audio Failed Login: Missing Login Data
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding HIGHRESAUDIO REST API Endpoints
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 25 14:41:18 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Feb 25 14:41:18 volumio2 volumio[1173]: info: Refreshing TIDAL token
Feb 25 14:41:18 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Feb 25 14:41:18 volumio2 volumio[1173]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Feb 25 14:41:18 volumio2 sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 25 14:41:18 volumio2 sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:18 volumio2 volumio[1173]: info: Stopping AccessToken refresher cron for QOBUZ
Feb 25 14:41:18 volumio2 sudo[1670]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:18 volumio2 volumio[1173]: info: AccessToken refresher cron started for QOBUZ
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding QOBUZ REST API Endpoints
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:18 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:18 volumio2 volumio[1173]: info: Updating MyVolumio device info
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 25 14:41:18 volumio2 volumio[1173]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 25 14:41:18 volumio2 volumio[1173]: info: Listing playlists
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetQueue
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreStateMachine::getQueue
Feb 25 14:41:18 volumio2 volumio[1173]: info: CorePlayQueue::getQueue
Feb 25 14:41:18 volumio2 volumio[1173]: info: Successfully Added MyVolumio device
Feb 25 14:41:18 volumio2 volumio[1173]: info: Successfully Updated MyVolumio device
Feb 25 14:41:18 volumio2 volumio[1173]: info: Successfully Added MyVolumio device
Feb 25 14:41:18 volumio2 volumio[1173]: info: MRS: Adding multiroomSync output
Feb 25 14:41:18 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:18 volumio2 ntpd[751]: Soliciting pool server 194.58.204.148
Feb 25 14:41:18 volumio2 ntpd[751]: Soliciting pool server 45.83.221.52
Feb 25 14:41:18 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output
Feb 25 14:41:18 volumio2 volumio[1173]: info: Bluetooth name changed to Volumio2
Feb 25 14:41:18 volumio2 volumio[1173]: info: MPD Permissions set
Feb 25 14:41:18 volumio2 ntpd[751]: Soliciting pool server 192.36.143.130
Feb 25 14:41:18 volumio2 volumio[1173]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:18 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:19 volumio2 volumio[1173]: info: Received Get System Info
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 14:41:19 volumio2 volumio[1173]: info: Discovery: Getting this device information
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:19 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:19 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:19 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:41:19 volumio2 sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:41:19 volumio2 sudo[1682]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:19 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 25 14:41:19 volumio2 systemd[1]: shairport-sync.service: Succeeded.
Feb 25 14:41:19 volumio2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:19 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:19 volumio2 sudo[1682]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:19 volumio2 volumio[1173]: info: MRS: Found cast device: Chromecast-HD-8c667faf85c82b3d884c24f8daff4483
Feb 25 14:41:19 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:19 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:41:19 volumio2 volumio[1173]: info: Access Token successfully retrieved
Feb 25 14:41:19 volumio2 volumio[1173]: info: MRS: Found cast device: Chromecast-baa18719d7e2e4204b707191799645aa
Feb 25 14:41:19 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:19 volumio2 ntpd[751]: Soliciting pool server 194.58.205.148
Feb 25 14:41:19 volumio2 ntpd[751]: Soliciting pool server 162.159.200.123
Feb 25 14:41:19 volumio2 sudo[1696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 25 14:41:19 volumio2 sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:19 volumio2 sudo[1696]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:19 volumio2 sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 25 14:41:19 volumio2 sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:19 volumio2 sudo[1698]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:19 volumio2 volumio[1173]: verbose: New Socket.io Connection to 192.168.1.236 from 192.168.1.171 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Feb 25 14:41:19 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Home-bf67db836a82cf67c72a77aeaf93173a
Feb 25 14:41:19 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:19 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Cast-Group-124df1b6d68d4fe4b0a6fd015dceb941-1
Feb 25 14:41:19 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:19 volumio2 ntpd[751]: Soliciting pool server 192.36.143.134
Feb 25 14:41:19 volumio2 volumio[1173]: info: Successfully Updated MyVolumio device
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:19 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 14:41:19 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 25 14:41:19 volumio2 volumio[1173]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 25 14:41:20 volumio2 volumio[1173]: info: Listing playlists
Feb 25 14:41:20 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetQueue
Feb 25 14:41:20 volumio2 volumio[1173]: info: CoreStateMachine::getQueue
Feb 25 14:41:20 volumio2 volumio[1173]: info: CorePlayQueue::getQueue
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Cast-Group-124df1b6d68d4fe4b0a6fd015dceb941
Feb 25 14:41:20 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Home-Mini-d1aabd63a24e7033102e14e29d71d000
Feb 25 14:41:20 volumio2 volumio[1173]: info: Adding audio output:
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Cast-Group-124df1b6d68d4fe4b0a6fd015dceb941-1
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Chromecast-baa18719d7e2e4204b707191799645aa
Feb 25 14:41:20 volumio2 ntpd[751]: Soliciting pool server 77.239.113.15
Feb 25 14:41:20 volumio2 ntpd[751]: Soliciting pool server 194.58.207.148
Feb 25 14:41:20 volumio2 ntpd[751]: Soliciting pool server 98.128.230.186
Feb 25 14:41:20 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:41:20 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:20 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Home-bf67db836a82cf67c72a77aeaf93173a
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Home-Mini-d1aabd63a24e7033102e14e29d71d000
Feb 25 14:41:20 volumio2 volumio[1173]: info: MRS: Found cast device: Google-Cast-Group-124df1b6d68d4fe4b0a6fd015dceb941
Feb 25 14:41:20 volumio2 sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Feb 25 14:41:20 volumio2 sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:20 volumio2 volumio[1173]: info: Successfully retrieved User Session From TIDAL
Feb 25 14:41:21 volumio2 mpd[1668]: Feb 25 14:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 25 14:41:21 volumio2 volumio[1173]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Feb 25 14:41:21 volumio2 systemd[1]: Started Volumio Bluetooth Module.
Feb 25 14:41:21 volumio2 systemd[1]: Started Music Player Daemon.
Feb 25 14:41:21 volumio2 sudo[1642]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:21 volumio2 sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Feb 25 14:41:21 volumio2 sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:21 volumio2 volumiobt[1720]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Feb 25 14:41:21 volumio2 sudo[1723]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:21 volumio2 sudo[1708]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:21 volumio2 volumio[1173]: info: MRS: Found cast device: Chromecast-HD-8c667faf85c82b3d884c24f8daff4483
Feb 25 14:41:21 volumio2 volumio[1173]: info: Volumio BT Module successfully started
Feb 25 14:41:21 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetState
Feb 25 14:41:21 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:21 volumio2 volumio[1173]: error: updateQueue error: null
Feb 25 14:41:21 volumio2 volumio-remote-updater[576]: No test mode
Feb 25 14:41:21 volumio2 volumio-remote-updater[576]: No alpha test mode
Feb 25 14:41:21 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Feb 25 14:41:21 volumio2 volumio[1173]: info: TidalConnect service stoped!
Feb 25 14:41:21 volumio2 volumio[1173]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Feb 25 14:41:21 volumio2 volumio[1173]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Feb 25 14:41:21 volumio2 sudo[1736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Feb 25 14:41:21 volumio2 sudo[1736]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:21 volumio2 volumio[1173]: info: Successfully retrieved User Subscription From TIDAL
Feb 25 14:41:21 volumio2 volumio[1173]: info: Adding TIDAL to Browse Sources
Feb 25 14:41:21 volumio2 volumio[1173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 25 14:41:21 volumio2 volumio[1173]: info: [1740490881574] CoreMusicLibrary::Adding element TIDAL
Feb 25 14:41:21 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 14:41:21 volumio2 volumio[1173]: Cannot find translation for source TIDAL
Feb 25 14:41:21 volumio2 volumio[1173]: info: Stopping AccessToken refresher cron
Feb 25 14:41:21 volumio2 systemd[1]: Started Volumio Tidal Connect Service.
Feb 25 14:41:21 volumio2 sudo[1736]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:21 volumio2 volumio[1173]: info: AccessToken refresher cron started
Feb 25 14:41:21 volumio2 volumio[1173]: info: Adding TIDAL REST API Endpoints
Feb 25 14:41:21 volumio2 volumio[1173]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Feb 25 14:41:21 volumio2 ntpd[751]: Soliciting pool server 85.24.237.71
Feb 25 14:41:21 volumio2 ntpd[751]: Soliciting pool server 194.58.204.20
Feb 25 14:41:21 volumio2 volumio[1173]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Feb 25 14:41:21 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 25 14:41:22 volumio2 sudo[1741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Feb 25 14:41:22 volumio2 sudo[1741]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:22 volumio2 volumiobt[1720]: pulseaudio: no process found
Feb 25 14:41:22 volumio2 sudo[1741]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:22 volumio2 dbus-daemon[597]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.36' (uid=1000 pid=1746 comm="/usr/bin/pulseaudio --high-priority=true ")
Feb 25 14:41:22 volumio2 volumio[1173]: info: Executing endpoint tc_getconfig
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Feb 25 14:41:22 volumio2 vtcs[1738]: STARTING TidalConnect services, version: 1.4.0.34
Feb 25 14:41:22 volumio2 systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Feb 25 14:41:22 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:22 volumio2 dbus-daemon[597]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Feb 25 14:41:22 volumio2 systemd[1]: Started RealtimeKit Scheduling Policy Service.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Successfully called chroot.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Successfully dropped privileges.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Successfully limited resources.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Running.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Canary thread running.
Feb 25 14:41:22 volumio2 rtkit-daemon[1747]: Watchdog thread running.
Feb 25 14:41:22 volumio2 dbus-daemon[597]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.37' (uid=0 pid=1747 comm="/usr/lib/rtkit/rtkit-daemon ")
Feb 25 14:41:22 volumio2 systemd[1]: Starting Authorization Manager...
Feb 25 14:41:22 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:22 volumio2 vtcs[1738]: STARTED TidalConnect services.
Feb 25 14:41:22 volumio2 volumio[1173]: info: Executing endpoint tc_connect
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Feb 25 14:41:22 volumio2 volumio[1173]: info: Connecting to TidalConnect
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::servicePushState
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:41:22 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:41:22 volumio2 polkitd[1751]: started daemon version 0.105 using authority implementation `local' version `0.105'
Feb 25 14:41:22 volumio2 dbus-daemon[597]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Feb 25 14:41:22 volumio2 systemd[1]: Started Authorization Manager.
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output update for this device
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output
Feb 25 14:41:22 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:22 volumio2 volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::servicePushState
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:41:22 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:22 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output update for this device
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output
Feb 25 14:41:22 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:22 volumio2 volumio[1173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect
Feb 25 14:41:22 volumio2 ntpd[751]: Soliciting pool server 147.78.228.41
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Getting audio outputs on start
Feb 25 14:41:22 volumio2 volumio[1173]: info: MRS: Requesting all other devices output
Feb 25 14:41:23 volumio2 pulseaudio[1746]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Feb 25 14:41:23 volumio2 pulseaudio[1746]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Feb 25 14:41:23 volumio2 volumiobt[1720]: Applying permissions
Feb 25 14:41:23 volumio2 volumiobt[1720]: Setting BT discoverable and pairable
Feb 25 14:41:23 volumio2 bluetoothd[745]: Endpoint registered: sender=:1.58 path=/MediaEndpoint/A2DPSource
Feb 25 14:41:23 volumio2 bluetoothd[745]: Endpoint registered: sender=:1.58 path=/MediaEndpoint/A2DPSink
Feb 25 14:41:23 volumio2 pulseaudio[1746]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Feb 25 14:41:23 volumio2 kernel: Bluetooth: RFCOMM TTY layer initialized
Feb 25 14:41:23 volumio2 kernel: Bluetooth: RFCOMM socket layer initialized
Feb 25 14:41:23 volumio2 kernel: Bluetooth: RFCOMM ver 1.11
Feb 25 14:41:23 volumio2 volumiobt[1720]: [CHG] Controller B8:27:EB:14:9C:05 UUIDs: 00001112-0000-1000-8000-00805f9b34fb
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [117B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [55B blob data]
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# -e power on
Feb 25 14:41:23 volumio2 volumiobt[1720]: Invalid command in menu main: -e
Feb 25 14:41:23 volumio2 volumiobt[1720]:
Feb 25 14:41:23 volumio2 volumiobt[1720]: Use "help" for a list of available commands in a menu.
Feb 25 14:41:23 volumio2 volumiobt[1720]: Use "menu " if you want to enter any submenu.
Feb 25 14:41:23 volumio2 volumiobt[1720]: Use "back" if you want to return to menu main.
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# agent on
Feb 25 14:41:23 volumio2 volumiobt[1720]: Agent is already registered
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# discoverable on
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# pairable on
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# agent NoInputNoOutput
Feb 25 14:41:23 volumio2 volumiobt[1720]: Agent is already registered
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# default-agent
Feb 25 14:41:23 volumio2 volumiobt[1720]: [bluetooth]# quit
Feb 25 14:41:23 volumio2 volumiobt[1720]: [59B blob data]
Feb 25 14:41:23 volumio2 ntpd[751]: Soliciting pool server 2001:9b1:9bd0::bb
Feb 25 14:41:24 volumio2 volumio[1173]: info: TidalConnect service started!
Feb 25 14:41:24 volumio2 volumio[1173]: [Metrics] CommandRouter: 49s 525.04ms
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:24 volumio2 volumio[1173]: info: VolumeController:: Setting startup Volume 20
Feb 25 14:41:24 volumio2 volumio[1173]: info: VolumeController::SetAlsaVolume20
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreCommandRouter::Close All Modals sent
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreCommandRouter::Close All Modals sent
Feb 25 14:41:24 volumio2 volumio[1173]: info: CoreStateMachine::pushState
Feb 25 14:41:25 volumio2 volumio[1173]: info: CorePlayQueue::getTrack 0
Feb 25 14:41:25 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 14:41:25 volumio2 volumio[1173]: info: CoreCommandRouter::volumioPushState
Feb 25 14:41:26 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output update for this device
Feb 25 14:41:26 volumio2 volumio[1173]: info: MRS: Pushing multiroomSync output
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Feb 25 14:41:26 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 25 14:41:27 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:27 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Feb 25 14:41:30 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 14:41:30 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 25 14:41:32 volumio2 volumio[1173]: info: BOOT COMPLETED
Feb 25 14:41:34 volumio2 volumio[1173]: info: Enabling plugin fusiondsp
Feb 25 14:41:34 volumio2 volumio[1173]: info: Loading plugin "fusiondsp"...
Feb 25 14:41:35 volumio2 volumio[1173]: info: Preparing to generate the ALSA configuration file
Feb 25 14:41:35 volumio2 volumio[1173]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 14:41:35 volumio2 volumio[1173]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 25 14:41:35 volumio2 volumio[1173]: info: Reading ALSA contributions from plugins.
Feb 25 14:41:35 volumio2 volumio[1173]: info: Asound.conf file unchanged, so no further update is needed
Feb 25 14:41:35 volumio2 volumio[1173]: info: Output device has changed, restarting MPD
Feb 25 14:41:35 volumio2 sudo[1799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 25 14:41:35 volumio2 volumio[1173]: info: Output device has changed, restarting Shairport Sync
Feb 25 14:41:35 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:35 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:35 volumio2 sudo[1799]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:35 volumio2 sudo[1799]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:35 volumio2 sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 25 14:41:35 volumio2 sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 systemd[1]: Stopping Music Player Daemon...
Feb 25 14:41:36 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:36 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:41:36 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:36 volumio2 volumio[1173]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 systemd[1]: mpd.service: Succeeded.
Feb 25 14:41:36 volumio2 systemd[1]: Stopped Music Player Daemon.
Feb 25 14:41:36 volumio2 vtcs[1738]: [2025-02-25 14:41:36.140] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Feb 25 14:41:36 volumio2 systemd[1]: Starting Music Player Daemon...
Feb 25 14:41:36 volumio2 vtcs[1738]: [2025-02-25 14:41:36.143] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer
Feb 25 14:41:36 volumio2 vtcs[1738]: [2025-02-25 14:41:36.143] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
Feb 25 14:41:36 volumio2 volumio[1173]: info: PLUGIN START: fusiondsp
Feb 25 14:41:36 volumio2 sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 25 14:41:36 volumio2 volumio[1173]: info: Loading i18n strings for locale sv
Feb 25 14:41:36 volumio2 sudo[1811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: FusionDsp - mixtype--------------------- Hardware
Feb 25 14:41:36 volumio2 volumio[1173]: info: Preparing to generate the ALSA configuration file
Feb 25 14:41:36 volumio2 systemd[1]: Stopping Volumio Tidal Connect Service...
Feb 25 14:41:36 volumio2 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Feb 25 14:41:36 volumio2 systemd[1]: vtcs.service: Succeeded.
Feb 25 14:41:36 volumio2 systemd[1]: Stopped Volumio Tidal Connect Service.
Feb 25 14:41:36 volumio2 volumio[1173]: info: Done.
Feb 25 14:41:36 volumio2 sudo[1811]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 volumio[1173]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 25 14:41:36 volumio2 volumio[1173]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 25 14:41:36 volumio2 volumio[1173]: info: Reading ALSA contributions from plugins.
Feb 25 14:41:36 volumio2 sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 25 14:41:36 volumio2 sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:36 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:36 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:36 volumio2 sudo[1808]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 25 14:41:36 volumio2 sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 sudo[1808]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:36 volumio2 volumio[1173]: info: MPD Permissions set
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 sudo[1815]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:41:36 volumio2 volumio[1173]: info: Asound.conf file written
Feb 25 14:41:36 volumio2 sudo[1825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:41:36 volumio2 sudo[1825]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 25 14:41:36 volumio2 sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 25 14:41:36 volumio2 sudo[1828]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 systemd[1]: shairport-sync.service: Succeeded.
Feb 25 14:41:36 volumio2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:36 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:36 volumio2 sudo[1825]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:36 volumio2 volumio[1173]: info: Output device has changed, restarting MPD
Feb 25 14:41:36 volumio2 sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 25 14:41:36 volumio2 volumio[1173]: info: Output device has changed, restarting Shairport Sync
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:36 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:36 volumio2 sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:36 volumio2 sudo[1835]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:36 volumio2 sudo[1839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 25 14:41:36 volumio2 sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:37 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:37 volumio2 volumio[1173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 25 14:41:37 volumio2 volumio[1173]: xcb_connection_has_error() returned true
Feb 25 14:41:37 volumio2 volumio[1173]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 25 14:41:37 volumio2 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 25 14:41:37 volumio2 systemd[1]: mpd.service: Succeeded.
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:37 volumio2 systemd[1]: Stopped Music Player Daemon.
Feb 25 14:41:37 volumio2 systemd[1]: Starting Music Player Daemon...
Feb 25 14:41:37 volumio2 sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 25 14:41:37 volumio2 sudo[1850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 25 14:41:37 volumio2 sudo[1850]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:37 volumio2 sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:37 volumio2 volumio[1173]: info: MPD Permissions set
Feb 25 14:41:37 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:37 volumio2 sudo[1850]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:37 volumio2 sudo[1848]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 14:41:37 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:37 volumio2 volumio[1173]: info: Starting Shairport Sync
Feb 25 14:41:37 volumio2 sudo[1844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 25 14:41:37 volumio2 sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:37 volumio2 sudo[1844]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:37 volumio2 sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 25 14:41:37 volumio2 sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:37 volumio2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 25 14:41:37 volumio2 systemd[1]: shairport-sync.service: Succeeded.
Feb 25 14:41:37 volumio2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 25 14:41:37 volumio2 volumio[1173]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 25 14:41:37 volumio2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 25 14:41:37 volumio2 sudo[1860]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:37 volumio2 volumio[1173]: info: Shairport-Sync Started
Feb 25 14:41:38 volumio2 volumio[1173]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Feb 25 14:41:38 volumio2 volumio[1173]: info: camilladsp service started and running in background, instance 1
Feb 25 14:41:38 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 25 14:41:38 volumio2 volumio[1173]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 25 14:41:38 volumio2 volumio[1173]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 25 14:41:38 volumio2 volumio[1173]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 25 14:41:38 volumio2 volumio[1173]: info: FusionDsp loaded
Feb 25 14:41:38 volumio2 volumio[1173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 14:41:38 volumio2 sudo[1879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 25 14:41:38 volumio2 sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:38 volumio2 volumio[1173]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 25 14:41:38 volumio2 volumio[1173]: info: Adding Signal Path Element [object Object]
Feb 25 14:41:38 volumio2 volumio[1173]: info: Adding fusiondspeq DSP Signal Path Element
Feb 25 14:41:38 volumio2 volumio[1173]: info: FusionDsp - ---- installed callbackRead
Feb 25 14:41:38 volumio2 volumio[1173]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 14:41:38 volumio2 volumio[1173]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Feb 25 14:41:38 volumio2 volumio[1173]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Feb 25 14:41:38 volumio2 volumio[1173]: at onErrorNT (internal/child_process.js:465:16)
Feb 25 14:41:38 volumio2 volumio[1173]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Feb 25 14:41:38 volumio2 volumio[1173]: errno: -2,
Feb 25 14:41:38 volumio2 volumio[1173]: code: 'ENOENT',
Feb 25 14:41:38 volumio2 volumio[1173]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 25 14:41:38 volumio2 volumio[1173]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 25 14:41:38 volumio2 volumio[1173]: spawnargs: [
Feb 25 14:41:38 volumio2 volumio[1173]: '-p',
Feb 25 14:41:38 volumio2 volumio[1173]: 9876,
Feb 25 14:41:38 volumio2 volumio[1173]: '-o',
Feb 25 14:41:38 volumio2 volumio[1173]: '/tmp/camilladsp.log',
Feb 25 14:41:38 volumio2 volumio[1173]: '-l',
Feb 25 14:41:38 volumio2 volumio[1173]: 'warn',
Feb 25 14:41:38 volumio2 volumio[1173]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Feb 25 14:41:38 volumio2 volumio[1173]: ]
Feb 25 14:41:38 volumio2 volumio[1173]: }
Feb 25 14:41:38 volumio2 volumio[1173]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 14:41:38 volumio2 systemd[1]: Started FusionDsp Daemon.
Feb 25 14:41:38 volumio2 sudo[1879]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:39 volumio2 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 25 14:41:39 volumio2 systemd[1]: mpd.service: Failed with result 'protocol'.
Feb 25 14:41:39 volumio2 systemd[1]: Failed to start Music Player Daemon.
Feb 25 14:41:39 volumio2 sudo[1893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 14:40
Feb 25 14:41:39 volumio2 sudo[1893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 14:41:39 volumio2 sudo[1801]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:39 volumio2 sudo[1839]: pam_unix(sudo:session): session closed for user root
Feb 25 14:41:39 volumio2 systemd[1]: Starting Music Player Daemon...
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"