Jun 17 15:24:51 volumio ntpd[1018]: CLOCK: time stepped by 280816.104624 Jun 17 15:24:51 volumio ntpd[1018]: CLOCK: time changed from 2025-06-14 to 2025-06-17 Jun 17 15:24:51 volumio ntpd[1018]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 17 15:24:51 volumio volumio[1213]: info: Discovery: A device disappeared from network Jun 17 15:24:51 volumio volumio[1213]: info: Discovery: Device volumio disappeared from network Jun 17 15:24:51 volumio volumio[1213]: info: Discovery: A device disappeared from network Jun 17 15:24:51 volumio volumio[1213]: info: Discovery: A device disappeared from network Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: adding 50342ea3-a597-4fa8-921c-81ec365516be Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: Found device Volumio Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::volumioGetState Jun 17 15:24:52 volumio volumio[1213]: info: CorePlayQueue::getTrack 0 Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: this is already registered, 50342ea3-a597-4fa8-921c-81ec365516be Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: Found device Volumio Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::volumioGetState Jun 17 15:24:52 volumio volumio[1213]: info: CorePlayQueue::getTrack 0 Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: this is already registered, 50342ea3-a597-4fa8-921c-81ec365516be Jun 17 15:24:52 volumio volumio[1213]: info: Discovery: Found device Volumio Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::volumioGetState Jun 17 15:24:52 volumio volumio[1213]: info: CorePlayQueue::getTrack 0 Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 17 15:24:52 volumio volumio[1213]: info: Loading i18n strings for locale pl Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 17 15:24:52 volumio volumio[1213]: info: Setting timezone to Europe/Warsaw Jun 17 15:24:52 volumio sudo[2035]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 17 15:24:52 volumio sudo[2035]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:52 volumio sudo[2035]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:52 volumio sudo[2039]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Jun 17 15:24:52 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:52 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:52 volumio sudo[2044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 17 15:24:52 volumio sudo[2044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:52 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jun 17 15:24:52 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jun 17 15:24:52 volumio sudo[2044]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:52 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jun 17 15:24:52 volumio sudo[2051]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Jun 17 15:24:52 volumio sudo[2051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:52 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jun 17 15:24:52 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Jun 17 15:24:52 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jun 17 15:24:52 volumio systemd-timedated[1019]: Changed time zone to 'Europe/Warsaw' (CEST). Jun 17 15:24:52 volumio sudo[2051]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:52 volumio volumio[1213]: Updating browse sources language Jun 17 15:24:52 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 15:24:52 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jun 17 15:24:52 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jun 17 15:24:53 volumio volumio[1213]: info: Fetching Streaming Services browse cache Jun 17 15:24:53 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 17 15:24:53 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 17 15:24:53 volumio volumio[1213]: info: MyVolumio login type: Token Jun 17 15:24:54 volumio volumio[1213]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 17 15:24:54 volumio volumio[1213]: info: MyVolumio token set successfully Jun 17 15:24:54 volumio volumio[1213]: info: MYVOLUMIO: Adding device Jun 17 15:24:54 volumio volumio[1213]: info: MYVOLUMIO: Evaluating Server Jun 17 15:24:54 volumio volumio[1213]: info: MyVolumio Plan changed: premium Jun 17 15:24:54 volumio volumio[1213]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 17 15:24:54 volumio volumio[1213]: info: Removing browser output: myVolumio user plan is not superstar Jun 17 15:24:54 volumio volumio[1213]: info: Removing audio output: Jun 17 15:24:54 volumio volumio[1213]: info: MYVOLUMIO: Adding device Jun 17 15:24:54 volumio volumio[1213]: info: MYVOLUMIO: Evaluating Server Jun 17 15:24:54 volumio volumio[1213]: info: Remote config written successfully Jun 17 15:24:54 volumio volumio[1213]: info: Starting Tunnel 1 Jun 17 15:24:54 volumio volumio[1213]: info: Starting Tunnel Connection Checker Jun 17 15:24:54 volumio volumio[1213]: info: Completed starting MyVolumio Plugin Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 17 15:24:54 volumio volumio[1213]: info: Loading i18n strings for locale en Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jun 17 15:24:54 volumio volumio[1213]: info: Refreshing Cached IP Addresses Jun 17 15:24:54 volumio sudo[2126]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 17 15:24:54 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 17 15:24:54 volumio volumio[1213]: info: Setting timezone to Europe/Warsaw Jun 17 15:24:54 volumio sudo[2129]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 17 15:24:54 volumio sudo[2129]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2129]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio sudo[2131]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 17 15:24:54 volumio sudo[2131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2131]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio sudo[2135]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 17 15:24:54 volumio sudo[2135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2135]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio sudo[2140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Jun 17 15:24:54 volumio sudo[2140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2140]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio sudo[2144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 17 15:24:54 volumio sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2144]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio sudo[2148]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Jun 17 15:24:54 volumio sudo[2148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2148]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio volumio[1213]: Updating browse sources language Jun 17 15:24:54 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 15:24:54 volumio volumio[1213]: info: MYVolumio Device enabled Jun 17 15:24:54 volumio volumio[1213]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 17 15:24:54 volumio volumio[1213]: info: MyVolumio status changed Jun 17 15:24:54 volumio volumio[1213]: info: Streaming services startup Jun 17 15:24:54 volumio volumio[1213]: info: Starting Streaming Daemon Jun 17 15:24:54 volumio volumio[1213]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' Jun 17 15:24:54 volumio sudo[2169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 17 15:24:54 volumio sudo[2169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:54 volumio sudo[2169]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:54 volumio volumio[1213]: error: Cannot start Volumio Streaming Daemon Jun 17 15:24:54 volumio volumio[1213]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 17 15:24:54 volumio volumio[1213]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 17 15:24:55 volumio volumio[1213]: info: Setting Geolocation for MyVolumio to eu2 Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio dhcpcd[958]: wlan0: using IPv4LL address 169.254.201.160 Jun 17 15:24:55 volumio avahi-daemon[900]: Registering new address record for 169.254.201.160 on wlan0.IPv4. Jun 17 15:24:55 volumio dhcpcd[958]: wlan0: adding route to 169.254.0.0/16 Jun 17 15:24:55 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 17 15:24:55 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 17 15:24:55 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 17 15:24:55 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 17 15:24:55 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 17 15:24:55 volumio volumio[1213]: info: Fetching Streaming Services browse cache Jun 17 15:24:55 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 17 15:24:55 volumio welcome[2188]: Resolved ip:[3] 192.168.1.95 192.168.211.1 169.254.201.160 Jun 17 15:24:55 volumio volumio[1213]: info: Setting Geolocation for MyVolumio to eu9 Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:55 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 17 15:24:55 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 17 15:24:55 volumio volumio[1213]: info: Successfully Added MyVolumio device Jun 17 15:24:55 volumio volumio[1213]: info: Successfully Added MyVolumio device Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 17 15:24:56 volumio volumio[1213]: info: Loading i18n strings for locale en Jun 17 15:24:56 volumio volumio[1213]: Updating browse sources language Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 17 15:24:56 volumio volumio[1213]: info: Setting timezone to Europe/Warsaw Jun 17 15:24:56 volumio sudo[2195]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 17 15:24:56 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:56 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:56 volumio sudo[2199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Warsaw /etc/localtime Jun 17 15:24:56 volumio sudo[2199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:56 volumio sudo[2199]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:56 volumio sudo[2203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 17 15:24:56 volumio sudo[2203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:56 volumio sudo[2203]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:56 volumio sudo[2207]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Warsaw Jun 17 15:24:56 volumio sudo[2207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:56 volumio sudo[2207]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 17 15:24:56 volumio sudo[2210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 17 15:24:56 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:56 volumio volumio[1213]: info: Updating MyVolumio device info Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: Updating MyVolumio device info Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:56 volumio volumio[1213]: info: Fetching Streaming Services browse cache Jun 17 15:24:56 volumio volumio[1213]: info: Successfully Updated MyVolumio device Jun 17 15:24:56 volumio volumio[1213]: info: Successfully Updated MyVolumio device Jun 17 15:24:56 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 17 15:24:56 volumio ntpd[1018]: IO: Listen normally on 6 wlan0 169.254.201.160:123 Jun 17 15:24:56 volumio ntpd[1018]: IO: new interface(s) found: waking up resolver Jun 17 15:24:56 volumio volumio[1213]: info: [MyVolumio PluginManager] Plugin music_service/qobuzconnect is enabled for this plan, but could not be found on the local filesystem! Jun 17 15:24:56 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 17 15:24:57 volumio sudo[2214]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 17 15:24:57 volumio sudo[2214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2214]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: MRS: MultiRoom plugin initialized Jun 17 15:24:57 volumio volumio[1213]: info: MRS: STOPPING SNAPCLIENT Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Snap server stop Jun 17 15:24:57 volumio volumio[1213]: info: MRS: STOPPING volumioStreaming Jun 17 15:24:57 volumio sudo[2231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 17 15:24:57 volumio sudo[2231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 17 15:24:57 volumio sudo[2233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 17 15:24:57 volumio sudo[2236]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 17 15:24:57 volumio sudo[2238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 17 15:24:57 volumio sudo[2238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2238]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 17 15:24:57 volumio sudo[2231]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio sudo[2233]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 17 15:24:57 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 17 15:24:57 volumio volumio[1213]: info: Preparing to generate the ALSA configuration file Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Removed streaming files Jun 17 15:24:57 volumio volumio[1213]: info: MRS: volumioStreaming STOPPED Jun 17 15:24:57 volumio volumio[1213]: info: MRS: SNAPSERVER STOPPED Jun 17 15:24:57 volumio volumio[1213]: info: MRS: SNAPCLIENT STOPPED Jun 17 15:24:57 volumio volumio[1213]: info: Asound.conf file unchanged, so no further update is needed Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting MPD Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting Shairport Sync Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio sudo[2246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 17 15:24:57 volumio sudo[2246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2246]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio sudo[2249]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 17 15:24:57 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: [FUNC] onStart Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Pushing multiroomSync output for this device Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Pushing multiroomSync output Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jun 17 15:24:57 volumio volumio[1213]: info: Adding METAVOLUMIO REST API Endpoints Jun 17 15:24:57 volumio volumio[1213]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 17 15:24:57 volumio volumio[1213]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 17 15:24:57 volumio volumio[1213]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 17 15:24:57 volumio volumio[1213]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jun 17 15:24:57 volumio volumio[1213]: info: Preparing CD Folders Jun 17 15:24:57 volumio volumio[1213]: info: Adding CD REST API Endpoints Jun 17 15:24:57 volumio volumio[1213]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 17 15:24:57 volumio volumio[1213]: info: Starting UDEV Watcher for CD Jun 17 15:24:57 volumio volumio[1213]: info: Detecting CD presence with UDEV Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jun 17 15:24:57 volumio bluetoothd[901]: Adv Monitor app :1.31 disconnected from D-Bus Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jun 17 15:24:57 volumio volumio[1213]: info: Adding inputs REST Endpoints Jun 17 15:24:57 volumio volumio[1213]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 17 15:24:57 volumio volumio[1213]: info: Scanning Audio Inputs Jun 17 15:24:57 volumio volumio[1213]: info: Checking against Known Cards name Jun 17 15:24:57 volumio volumio[1213]: info: Adding Server instance for streaming Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jun 17 15:24:57 volumio volumio[1213]: error: Hi Res Audio Failed Login: Missing Login Data Jun 17 15:24:57 volumio volumio[1213]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jun 17 15:24:57 volumio volumio[1213]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jun 17 15:24:57 volumio volumio[1213]: info: Stopping AccessToken refresher cron Jun 17 15:24:57 volumio sudo[2266]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 17 15:24:57 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: AccessToken refresher cron started Jun 17 15:24:57 volumio volumio[1213]: info: Stopping AccessToken refresher cron for QOBUZ Jun 17 15:24:57 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 17 15:24:57 volumio volumio[1213]: info: AccessToken refresher cron started for QOBUZ Jun 17 15:24:57 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 17 15:24:57 volumio systemd[1]: mpd.service: Consumed 1.237s CPU time. Jun 17 15:24:57 volumio volumio[1213]: info: Adding TIDAL REST API Endpoints Jun 17 15:24:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 17 15:24:57 volumio volumio[1213]: info: Adding QOBUZ REST API Endpoints Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 17 15:24:57 volumio volumio[1213]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Jun 17 15:24:57 volumio volumio[1213]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 15:24:57 volumio volumio[1213]: info: MPD Permissions set Jun 17 15:24:57 volumio sudo[2270]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jun 17 15:24:57 volumio sudo[2270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: Starting Shairport Sync Jun 17 15:24:57 volumio systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Jun 17 15:24:57 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: Preparing to generate the ALSA configuration file Jun 17 15:24:57 volumio sudo[2279]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 17 15:24:57 volumio sudo[2279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2270]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumiobt[2283]: INFO [BTSTART] Ensuring Bluetooth directory exists... Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::volumioStop Jun 17 15:24:57 volumio volumio[1213]: info: CoreStateMachine::stop Jun 17 15:24:57 volumio volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 15:24:57 volumio volumio[1213]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Jun 17 15:24:57 volumio volumio[1213]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 15:24:57 volumio sudo[2273]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 17 15:24:57 volumio sudo[2273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 17 15:24:57 volumio sudo[2273]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: Asound.conf file unchanged, so no further update is needed Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting MPD Jun 17 15:24:57 volumio sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Jun 17 15:24:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 17 15:24:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 17 15:24:57 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2284]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio systemd[1]: shairport-sync.service: Consumed 1.443s CPU time. Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting Shairport Sync Jun 17 15:24:57 volumio sudo[2289]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 17 15:24:57 volumio sudo[2289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio sudo[2290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Jun 17 15:24:57 volumio sudo[2290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2279]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio sudo[2290]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio sudo[2289]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio sudo[2293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 17 15:24:57 volumio sudo[2293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumiobt[2297]: INFO [BTSTART] Powering on Bluetooth if needed... Jun 17 15:24:57 volumio volumio[1213]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 17 15:24:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 17 15:24:57 volumio volumio[1213]: info: Preparing to generate the ALSA configuration file Jun 17 15:24:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 17 15:24:57 volumio volumio[1213]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 15:24:57 volumio volumio[1213]: info: MPD Permissions set Jun 17 15:24:57 volumio volumio[1213]: info: Shairport-Sync Started Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio bluetoothd[901]: Adv Monitor app :1.32 disconnected from D-Bus Jun 17 15:24:57 volumio volumiobt[2323]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: Asound.conf file unchanged, so no further update is needed Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting MPD Jun 17 15:24:57 volumio volumio[1213]: info: Output device has changed, restarting Shairport Sync Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio sudo[2330]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 17 15:24:57 volumio volumiobt[2324]: [75B blob data] Jun 17 15:24:57 volumio volumiobt[2324]: [bluetooth]# pairable on Jun 17 15:24:57 volumio sudo[2330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio sudo[2330]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio bluetoothd[901]: Adv Monitor app :1.35 disconnected from D-Bus Jun 17 15:24:57 volumio volumiobt[2324]: [bluetooth]# Jun 17 15:24:57 volumio volumiobt[2338]: INFO [BTSTART] Registering Bluetooth agent... Jun 17 15:24:57 volumio sudo[2332]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 17 15:24:57 volumio sudo[2332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio bluetoothd[901]: Adv Monitor app :1.36 disconnected from D-Bus Jun 17 15:24:57 volumio volumio[1213]: info: MPD Permissions set Jun 17 15:24:57 volumio volumio[1213]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 15:24:57 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 17 15:24:57 volumio volumio[1213]: info: Starting Shairport Sync Jun 17 15:24:57 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 17 15:24:57 volumio volumiobt[2343]: No agent is registered Jun 17 15:24:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 17 15:24:57 volumio volumiobt[2344]: INFO [BTSTART] Agent registered successfully. Jun 17 15:24:57 volumio bluetoothd[901]: Adv Monitor app :1.37 disconnected from D-Bus Jun 17 15:24:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 17 15:24:57 volumio volumiobt[2347]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 17 15:24:57 volumio sudo[2348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 17 15:24:57 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 17 15:24:57 volumio volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 17 15:24:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 17 15:24:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: Starting Shairport Sync Jun 17 15:24:57 volumio sudo[2350]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 17 15:24:57 volumio sudo[2350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 17 15:24:57 volumio sudo[2350]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: Shairport-Sync Started Jun 17 15:24:57 volumio sudo[2362]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 17 15:24:57 volumio sudo[2362]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 17 15:24:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 17 15:24:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 17 15:24:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Found cast device: Chromecast-126478d7885e6754f0777777589e686d Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 17 15:24:57 volumio sudo[2362]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:57 volumio volumio[1213]: info: Shairport-Sync Started Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Found cast device: OLED55B46LA.DEUQLJP-6d13ba1ef10d3508758950bc869e3b32 Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Found cast device: Google-Cast-Group-0ba375e3b1644460a8ccec4b599c3493 Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:57 volumio volumio[1213]: info: MRS: Found cast device: Google-Nest-Hub-f81cd4314407b51d40cf5ac690ed4c24 Jun 17 15:24:57 volumio volumio[1213]: info: Adding audio output: Jun 17 15:24:58 volumio volumiobt[2352]: INFO:a2dp-agent:Connecting to system bus. Jun 17 15:24:58 volumio volumiobt[2352]: INFO:a2dp-agent:Found Bluetooth adapter at: /org/bluez/hci0 Jun 17 15:24:58 volumio volumiobt[2352]: INFO:a2dp-agent:Enabling infinite discovery on adapter. Jun 17 15:24:58 volumio volumiobt[2352]: INFO:a2dp-agent:Registering agent. Jun 17 15:24:58 volumio volumiobt[2352]: INFO:a2dp-agent:Searching for MediaPlayer1 interface... Jun 17 15:24:58 volumio volumiobt[2352]: WARNING:a2dp-agent:No active MediaPlayer1 found. Metadata updates won't work. Jun 17 15:24:58 volumio mpd[2364]: 2025-06-17T15:24:58 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 17 15:24:58 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jun 17 15:24:58 volumio sudo[2293]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:58 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:58 volumio sudo[2332]: pam_unix(sudo:session): session closed for user root Jun 17 15:24:58 volumio volumio[1213]: error: MPD error: The expression evaluated to a falsy value: Jun 17 15:24:58 volumio volumio[1213]: assert.ok(self.idling) Jun 17 15:24:58 volumio volumio[1213]: error: The expression evaluated to a falsy value: Jun 17 15:24:58 volumio volumio[1213]: assert.ok(self.idling) Jun 17 15:24:58 volumio volumio[1213]: error: updateQueue error: null Jun 17 15:24:58 volumio volumio[1213]: error: updateQueue error: null Jun 17 15:24:58 volumio volumio[1213]: compat.c: read() failed: Resource temporarily unavailable Jun 17 15:24:58 volumio volumio[1213]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 15:24:58 volumio volumio[1213]: Error: dns service error: unknown Jun 17 15:24:58 volumio volumio[1213]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jun 17 15:24:58 volumio volumio[1213]: errorCode: -65537 Jun 17 15:24:58 volumio volumio[1213]: } Jun 17 15:24:58 volumio volumio[1213]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 15:24:58 volumio sudo[2426]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-17 15:23' Jun 17 15:24:58 volumio sudo[2426]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cee9bb5b0ee50e4898478097a64b5c6c77d5a212" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 14 07:24:14 UTC 2025" VOLUMIO_VERSION="4.012" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b365b054264e3ebc2709665da2b5d1ee"