Dec 21 13:37:42 emilyberry ntpd[837]: CLOCK: time stepped by 75.636736 Dec 21 13:37:42 emilyberry ntpd[837]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 21 13:37:42 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin bluetooth to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin multiroom to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin metavolumio to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin cd_controller to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 21 13:37:42 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 21 13:37:43 emilyberry volumio[1068]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 21 13:37:43 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 21 13:37:43 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:43 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:43 emilyberry volumio[1068]: info: Starting MyVolumio Remote Streaming Endpoints Dec 21 13:37:43 emilyberry volumio[1068]: info: MyVolumio login type: Token Dec 21 13:37:43 emilyberry volumio[1068]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 21 13:37:43 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 21 13:37:45 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 21 13:37:45 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 21 13:37:45 emilyberry volumio[1068]: info: Streaming services startup Dec 21 13:37:45 emilyberry volumio[1068]: info: Starting Streaming Daemon Dec 21 13:37:45 emilyberry sudo[3055]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 21 13:37:45 emilyberry sudo[3055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 21 13:37:45 emilyberry sudo[3055]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 13:37:45 emilyberry volumio[1068]: info: Received Get System Info Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:37:45 emilyberry volumio[1068]: info: Discovery: Getting this device information Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetState Dec 21 13:37:45 emilyberry volumio[1068]: info: CorePlayQueue::getTrack 0 Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 13:37:45 emilyberry volumio[1068]: info: Volumio Network Manager: Network status updated: 1 Dec 21 13:37:45 emilyberry volumio[1068]: error: Cannot start Volumio Streaming Daemon Dec 21 13:37:45 emilyberry volumio[1068]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 21 13:37:45 emilyberry volumio[1068]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 21 13:37:45 emilyberry sudo[3066]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 21 13:37:45 emilyberry sudo[3066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3071]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 21 13:37:45 emilyberry sudo[3071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3082]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 21 13:37:45 emilyberry sudo[3077]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 21 13:37:45 emilyberry sudo[3082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3071]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry sudo[3077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3066]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 21 13:37:45 emilyberry sudo[3077]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 21 13:37:45 emilyberry sudo[3088]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 21 13:37:45 emilyberry sudo[3088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3082]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry sudo[3088]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry sudo[3090]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 13:37:45 emilyberry sudo[3090]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry sudo[3090]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:45 emilyberry sudo[3097]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 21 13:37:45 emilyberry sudo[3097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:45 emilyberry volumio[1068]: error: MyVolumio Custom Token format not valid, refreshing it Dec 21 13:37:46 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 21 13:37:46 emilyberry volumio[1068]: info: MyVolumio login type: Token Dec 21 13:37:46 emilyberry volumio[1068]: info: MyVolumio login type: Token Dec 21 13:37:46 emilyberry volumio[1068]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 21 13:37:47 emilyberry volumio[1068]: info: MyVolumio token set successfully Dec 21 13:37:47 emilyberry volumio[1068]: info: MYVOLUMIO: Adding device Dec 21 13:37:47 emilyberry volumio[1068]: info: MYVOLUMIO: Evaluating Server Dec 21 13:37:47 emilyberry volumio[1068]: info: MyVolumio Plan changed: superstar Dec 21 13:37:47 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Dec 21 13:37:47 emilyberry volumio[1068]: info: Adding audio output: Dec 21 13:37:47 emilyberry volumio[1068]: info: MYVOLUMIO: Adding device Dec 21 13:37:47 emilyberry volumio[1068]: info: MYVOLUMIO: Evaluating Server Dec 21 13:37:47 emilyberry volumio[1068]: info: Remote config written successfully Dec 21 13:37:47 emilyberry volumio[1068]: info: Starting Tunnel 1 Dec 21 13:37:47 emilyberry volumio[1068]: info: Starting Tunnel Connection Checker Dec 21 13:37:47 emilyberry volumio[1068]: info: MYVolumio Device enabled Dec 21 13:37:47 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 21 13:37:47 emilyberry volumio[1068]: info: MyVolumio status changed Dec 21 13:37:47 emilyberry volumio[1068]: info: Streaming services startup Dec 21 13:37:47 emilyberry volumio[1068]: info: Starting Streaming Daemon Dec 21 13:37:47 emilyberry sudo[3139]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 21 13:37:47 emilyberry sudo[3139]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:47 emilyberry volumio[1068]: info: Setting Geolocation for MyVolumio to eu4 Dec 21 13:37:47 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:47 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:47 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:47 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Dec 21 13:37:47 emilyberry sudo[3139]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:47 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Dec 21 13:37:48 emilyberry sudo[3097]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:48 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Dec 21 13:37:48 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Dec 21 13:37:49 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Dec 21 13:37:49 emilyberry sudo[3143]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 21 13:37:49 emilyberry sudo[3143]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:49 emilyberry sudo[3143]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: MultiRoom plugin initialized Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: STOPPING SNAPCLIENT Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Snap server stop Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: STOPPING volumioStreaming Dec 21 13:37:50 emilyberry sudo[3162]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 21 13:37:50 emilyberry sudo[3162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry sudo[3164]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 21 13:37:50 emilyberry sudo[3164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Dec 21 13:37:50 emilyberry sudo[3170]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 21 13:37:50 emilyberry sudo[3170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry sudo[3170]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry sudo[3166]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Dec 21 13:37:50 emilyberry sudo[3166]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Dec 21 13:37:50 emilyberry sudo[3164]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry sudo[3162]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Dec 21 13:37:50 emilyberry sudo[3166]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Dec 21 13:37:50 emilyberry volumio[1068]: info: Preparing to generate the ALSA configuration file Dec 21 13:37:50 emilyberry volumio[1068]: info: Updating MyVolumio device info Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 21 13:37:50 emilyberry volumio[1068]: info: Reading ALSA contributions from plugins. Dec 21 13:37:50 emilyberry volumio[1068]: info: Setting Geolocation for MyVolumio to eu7 Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: Successfully Added MyVolumio device Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 13:37:50 emilyberry volumio[1068]: info: Received Get System Info Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:37:50 emilyberry volumio[1068]: info: Discovery: Getting this device information Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetState Dec 21 13:37:50 emilyberry volumio[1068]: info: CorePlayQueue::getTrack 0 Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Removed streaming files Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: volumioStreaming STOPPED Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: SNAPSERVER STOPPED Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: SNAPCLIENT STOPPED Dec 21 13:37:50 emilyberry volumio[1068]: error: Cannot start Volumio Streaming Daemon Dec 21 13:37:50 emilyberry volumio[1068]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 21 13:37:50 emilyberry volumio[1068]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 21 13:37:50 emilyberry volumio[1068]: info: Asound.conf file written Dec 21 13:37:50 emilyberry sudo[3177]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 21 13:37:50 emilyberry sudo[3177]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry sudo[3177]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry volumio[1068]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 21 13:37:50 emilyberry volumio[1068]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 21 13:37:50 emilyberry volumio[1068]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 21 13:37:50 emilyberry volumio[1068]: info: Output device has changed, restarting MPD Dec 21 13:37:50 emilyberry volumio[1068]: info: Output device has changed, restarting Shairport Sync Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:50 emilyberry sudo[3183]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 13:37:50 emilyberry sudo[3183]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry sudo[3183]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:50 emilyberry sudo[3187]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 13:37:50 emilyberry sudo[3187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:50 emilyberry volumio[1068]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Dec 21 13:37:50 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: [FUNC] onStart Dec 21 13:37:50 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Dec 21 13:37:50 emilyberry systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 21 13:37:50 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Dec 21 13:37:50 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Dec 21 13:37:50 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output for this device Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding audio output: Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding audio output: Dec 21 13:37:50 emilyberry volumio[1068]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding METAVOLUMIO REST API Endpoints Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Dec 21 13:37:50 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Dec 21 13:37:50 emilyberry volumio[1068]: info: Preparing CD Folders Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding CD REST API Endpoints Dec 21 13:37:50 emilyberry volumio[1068]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 21 13:37:50 emilyberry volumio[1068]: info: Starting UDEV Watcher for CD Dec 21 13:37:50 emilyberry volumio[1068]: info: Detecting CD presence with UDEV Dec 21 13:37:50 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 21 13:37:50 emilyberry bluetoothd[880]: Path / reserved for Adv Monitor app :1.18 Dec 21 13:37:50 emilyberry bluetoothd[880]: Adv Monitor app :1.18 disconnected from D-Bus Dec 21 13:37:50 emilyberry systemd[1]: mpd.service: Deactivated successfully. Dec 21 13:37:50 emilyberry systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 13:37:50 emilyberry systemd[1]: mpd.service: Consumed 6.479s CPU time. Dec 21 13:37:50 emilyberry systemd[1]: mpd.socket: Deactivated successfully. Dec 21 13:37:50 emilyberry systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 13:37:50 emilyberry systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 13:37:51 emilyberry systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 13:37:51 emilyberry systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 13:37:51 emilyberry sudo[3203]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 13:37:51 emilyberry sudo[3203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:37:51 emilyberry sudo[3203]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:53 emilyberry mpd[3205]: 2025-12-21T13:37:53 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 21 13:37:54 emilyberry systemd[1]: Started mpd.service - Music Player Daemon. Dec 21 13:37:54 emilyberry sudo[3187]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:55 emilyberry volumio[1068]: warn: [cd-plugin] cdspeedctl: device or media not ready Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding inputs REST Endpoints Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Dec 21 13:37:55 emilyberry volumio[1068]: info: Scanning Audio Inputs Dec 21 13:37:55 emilyberry volumio[1068]: info: Checking against Known Cards name Dec 21 13:37:55 emilyberry volumio[1068]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 21 13:37:55 emilyberry volumio[1068]: info: [1766320675918] CoreMusicLibrary::Adding element HiFiBerry ADC Dec 21 13:37:55 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 13:37:55 emilyberry volumio[1068]: Cannot find translation for source HiFiBerry ADC Dec 21 13:37:55 emilyberry volumio[1068]: info: Checking against Known Cards name Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding Server instance for streaming Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Dec 21 13:37:55 emilyberry volumio[1068]: error: Hi Res Audio Failed Login: Missing Login Data Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Dec 21 13:37:55 emilyberry volumio[1068]: info: [MyVolumio PluginManager] Plugin qobuzconnect disabled by user. Not starting Dec 21 13:37:55 emilyberry volumio[1068]: info: Adding TIDAL REST API Endpoints Dec 21 13:37:55 emilyberry volumio[1068]: info: Stopping AccessToken refresher cron for QOBUZ Dec 21 13:37:55 emilyberry sudo[3231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 21 13:37:55 emilyberry sudo[3231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry volumio[1068]: info: AccessToken refresher cron started for QOBUZ Dec 21 13:37:56 emilyberry volumio[1068]: info: Adding QOBUZ REST API Endpoints Dec 21 13:37:56 emilyberry volumio[1068]: info: MRS: Getting audio outputs on start Dec 21 13:37:56 emilyberry volumio[1068]: info: MRS: Requesting all other devices output Dec 21 13:37:56 emilyberry sudo[3231]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumio[1068]: info: Updating MyVolumio device info Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: Successfully Updated MyVolumio device Dec 21 13:37:56 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Dec 21 13:37:56 emilyberry volumio[1068]: info: MPD Permissions set Dec 21 13:37:56 emilyberry sudo[3235]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 21 13:37:56 emilyberry sudo[3235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:37:56 emilyberry volumio[1068]: error: updateQueue error: null Dec 21 13:37:56 emilyberry systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Dec 21 13:37:56 emilyberry volumio[1068]: info: Starting Shairport Sync Dec 21 13:37:56 emilyberry sudo[3235]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumiobt[3254]: INFO [BTSTART] Ensuring Bluetooth directory exists... Dec 21 13:37:56 emilyberry sudo[3252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 13:37:56 emilyberry sudo[3252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry sudo[3255]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Dec 21 13:37:56 emilyberry sudo[3255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreCommandRouter::volumioStop Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreStateMachine::stop Dec 21 13:37:56 emilyberry sudo[3255]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 21 13:37:56 emilyberry volumio[1068]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Dec 21 13:37:56 emilyberry volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 21 13:37:56 emilyberry systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 21 13:37:56 emilyberry systemd[1]: shairport-sync.service: Deactivated successfully. Dec 21 13:37:56 emilyberry systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:37:56 emilyberry systemd[1]: shairport-sync.service: Consumed 4.580s CPU time. Dec 21 13:37:56 emilyberry sudo[3258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Dec 21 13:37:56 emilyberry sudo[3258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry sudo[3258]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumiobt[3261]: INFO [BTSTART] Powering on Bluetooth if needed... Dec 21 13:37:56 emilyberry sudo[3265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 21 13:37:56 emilyberry sudo[3265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:56 emilyberry volumio[1068]: info: Successfully Updated MyVolumio device Dec 21 13:37:56 emilyberry systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 21 13:37:56 emilyberry sudo[3252]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumio[1068]: info: Shairport-Sync Started Dec 21 13:37:56 emilyberry systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 21 13:37:56 emilyberry systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 21 13:37:56 emilyberry systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 21 13:37:56 emilyberry sudo[3265]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:56 emilyberry volumio[1068]: info: Remote SSH Started Dec 21 13:37:56 emilyberry autossh[3280]: port set to 0, monitoring disabled Dec 21 13:37:56 emilyberry autossh[3280]: starting ssh (count 1) Dec 21 13:37:56 emilyberry autossh[3280]: ssh child pid is 3285 Dec 21 13:37:56 emilyberry bluetoothd[880]: Path / reserved for Adv Monitor app :1.19 Dec 21 13:37:56 emilyberry bluetoothd[880]: Adv Monitor app :1.19 disconnected from D-Bus Dec 21 13:37:56 emilyberry volumiobt[3286]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Dec 21 13:37:56 emilyberry volumiossh-tunnel[3285]: Warning: Permanently added '[eu7.myvolumio.org]:2222' (RSA) to the list of known hosts. Dec 21 13:37:56 emilyberry volumiobt[3287]: [195B blob data] Dec 21 13:37:56 emilyberry volumiobt[3287]: [159B blob data] Dec 21 13:37:56 emilyberry volumiobt[3287]: [159B blob data] Dec 21 13:37:56 emilyberry volumiobt[3287]: [159B blob data] Dec 21 13:37:56 emilyberry volumiobt[3287]: [115B blob data] Dec 21 13:37:56 emilyberry volumiobt[3287]: [Reinhards iPad]> discoverable on Dec 21 13:37:56 emilyberry volumiobt[3287]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Dec 21 13:37:56 emilyberry volumiobt[3287]: [Reinhards iPad]> pairable on Dec 21 13:37:56 emilyberry bluetoothd[880]: Path / reserved for Adv Monitor app :1.22 Dec 21 13:37:56 emilyberry volumio[1068]: info: Successfully Added MyVolumio device Dec 21 13:37:56 emilyberry volumio[1068]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 21 13:37:56 emilyberry bluetoothd[880]: Adv Monitor app :1.22 disconnected from D-Bus Dec 21 13:37:56 emilyberry volumiobt[3287]: [Reinhards iPad]> Dec 21 13:37:56 emilyberry volumiobt[3288]: INFO [BTSTART] Registering Bluetooth agent... Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetState Dec 21 13:37:57 emilyberry volumio[1068]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.dkiRamfDdXS5NcfJkemvfYBhlk12.d2c8f063187bda3434be76f94d11eaa4.state.status' Dec 21 13:37:57 emilyberry volumiobt[3289]: [NEW] Media /org/bluez/hci0 Dec 21 13:37:57 emilyberry volumiobt[3289]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry volumiobt[3289]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry volumiobt[3289]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry bluetoothd[880]: Path / reserved for Adv Monitor app :1.23 Dec 21 13:37:57 emilyberry bluetoothd[880]: Adv Monitor app :1.23 disconnected from D-Bus Dec 21 13:37:57 emilyberry volumiobt[3290]: No agent is registered Dec 21 13:37:57 emilyberry volumiobt[3290]: [NEW] Media /org/bluez/hci0 Dec 21 13:37:57 emilyberry volumiobt[3290]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry volumiobt[3290]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry volumiobt[3290]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Dec 21 13:37:57 emilyberry bluetoothd[880]: Path / reserved for Adv Monitor app :1.24 Dec 21 13:37:57 emilyberry bluetoothd[880]: Adv Monitor app :1.24 disconnected from D-Bus Dec 21 13:37:57 emilyberry volumiobt[3291]: INFO [BTSTART] Agent registered successfully. Dec 21 13:37:57 emilyberry volumiobt[3292]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 21 13:37:57 emilyberry volumio[1068]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 21 13:37:57 emilyberry volumio[1068]: info: Received Get System Version Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 21 13:37:57 emilyberry volumio[1068]: info: Received Get System Info Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 21 13:37:57 emilyberry volumio[1068]: info: Discovery: Getting this device information Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetState Dec 21 13:37:57 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 21 13:37:58 emilyberry volumiobt[3293]: INFO:a2dp-agent:Connecting to system bus. Dec 21 13:37:58 emilyberry volumiobt[3293]: INFO:a2dp-agent:Found Bluetooth adapter at: /org/bluez/hci0 Dec 21 13:37:58 emilyberry volumiobt[3293]: INFO:a2dp-agent:Enabling infinite discovery on adapter. Dec 21 13:37:58 emilyberry volumiobt[3293]: INFO:a2dp-agent:Registering agent. Dec 21 13:37:58 emilyberry volumiobt[3293]: INFO:a2dp-agent:Searching for MediaPlayer1 interface... Dec 21 13:37:58 emilyberry volumiobt[3293]: WARNING:a2dp-agent:No active MediaPlayer1 found. Metadata updates won't work. Dec 21 13:37:58 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 21 13:37:58 emilyberry volumio[1068]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Dec 21 13:37:58 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetState Dec 21 13:37:59 emilyberry volumio[1068]: info: TidalConnect service stoped! Dec 21 13:37:59 emilyberry volumio[1068]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:37:59 emilyberry volumio[1068]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 21 13:37:59 emilyberry sudo[3303]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 21 13:37:59 emilyberry sudo[3303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:59 emilyberry sudo[3306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 21 13:37:59 emilyberry sudo[3306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:37:59 emilyberry systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 21 13:37:59 emilyberry sudo[3303]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:59 emilyberry systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 21 13:37:59 emilyberry systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 21 13:37:59 emilyberry systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 21 13:37:59 emilyberry systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 21 13:37:59 emilyberry sudo[3306]: pam_unix(sudo:session): session closed for user root Dec 21 13:37:59 emilyberry mpd_monitor.sh[3311]: MPD Monitor Service: Starting MPD Monitor Service Dec 21 13:37:59 emilyberry volumio[1068]: info: Successfully started MPD Monitor Dec 21 13:37:59 emilyberry volumio[1068]: info: Executing endpoint tc_getconfig Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 21 13:37:59 emilyberry vtcs[3309]: STARTING TidalConnect services, version: 1.5.2.56 Dec 21 13:37:59 emilyberry vtcs[3309]: STARTED TidalConnect services. Dec 21 13:37:59 emilyberry volumio[1068]: info: Executing endpoint tc_connect Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 21 13:37:59 emilyberry volumio[1068]: info: Connecting to TidalConnect Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::servicePushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: info: CorePlayQueue::getTrack 0 Dec 21 13:37:59 emilyberry volumio[1068]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 21 13:37:59 emilyberry volumio[1068]: verbose: CURRENT POSITION 0 Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::syncState stateService stop Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::syncState currentStatus stop Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: info: No code Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::servicePushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: info: CorePlayQueue::getTrack 0 Dec 21 13:37:59 emilyberry volumio[1068]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 21 13:37:59 emilyberry volumio[1068]: verbose: CURRENT POSITION 0 Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::syncState stateService stop Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::syncState currentStatus stop Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: info: No code Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreStateMachine::pushState Dec 21 13:37:59 emilyberry volumio[1068]: info: CoreCommandRouter::volumioPushState Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output update for this device Dec 21 13:37:59 emilyberry volumio[1068]: info: MRS: Pushing multiroomSync output Dec 21 13:37:59 emilyberry volumio[1068]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.dkiRamfDdXS5NcfJkemvfYBhlk12.d2c8f063187bda3434be76f94d11eaa4.state.status' Dec 21 13:37:59 emilyberry volumio[1068]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.dkiRamfDdXS5NcfJkemvfYBhlk12.d2c8f063187bda3434be76f94d11eaa4.state.status' Dec 21 13:37:59 emilyberry volumio[1068]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.dkiRamfDdXS5NcfJkemvfYBhlk12.d2c8f063187bda3434be76f94d11eaa4.state.status' Dec 21 13:37:59 emilyberry volumio[1068]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.dkiRamfDdXS5NcfJkemvfYBhlk12.d2c8f063187bda3434be76f94d11eaa4.state.status' Dec 21 13:38:02 emilyberry volumio[1068]: info: TidalConnect service started! Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::volumioGetBrowseSources Dec 21 13:38:03 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 21 13:38:10 emilyberry volumio[1068]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 21 13:38:10 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 21 13:38:10 emilyberry sudo[3344]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 21 13:38:10 emilyberry sudo[3344]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:38:10 emilyberry sudo[3344]: pam_unix(sudo:session): session closed for user root Dec 21 13:38:10 emilyberry sudo[3346]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 21 13:38:10 emilyberry sudo[3346]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:38:10 emilyberry sudo[3346]: pam_unix(sudo:session): session closed for user root Dec 21 13:38:10 emilyberry volumio[1068]: info: Permissions for /etc/network/interfaces set Dec 21 13:38:10 emilyberry volumio[1068]: info: Restarting Wireless Network Dec 21 13:38:10 emilyberry volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 21 13:38:10 emilyberry volumio[1068]: info: Discovery: Restarting Advertising due to device name change Dec 21 13:38:11 emilyberry sudo[3349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 21 13:38:11 emilyberry sudo[3349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 13:38:11 emilyberry systemd[1]: Stopping wireless.service - Wireless Services... Dec 21 13:38:11 emilyberry systemd[1]: wireless.service: Deactivated successfully. Dec 21 13:38:11 emilyberry systemd[1]: Stopped wireless.service - Wireless Services. Dec 21 13:38:11 emilyberry systemd[1]: wireless.service: Consumed 9min 68ms CPU time. Dec 21 13:38:11 emilyberry systemd[1]: Starting wireless.service - Wireless Services... Dec 21 13:38:11 emilyberry wireless.js[3355]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 21 13:38:11 emilyberry wireless.js[3355]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 21 13:38:11 emilyberry wireless.js[3355]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 21 13:38:11 emilyberry wireless.js[3355]: WIRELESS.JS: Cleaning previous... Dec 21 13:38:11 emilyberry sudo[3375]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 21 13:38:11 emilyberry sudo[3375]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:38:11 emilyberry sudo[3375]: pam_unix(sudo:session): session closed for user root Dec 21 13:38:11 emilyberry sudo[3377]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 21 13:38:11 emilyberry sudo[3377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 13:38:12 emilyberry volumio[1068]: info: Discovery: A device disappeared from network Dec 21 13:38:12 emilyberry volumio[1068]: info: Discovery: Device emilyberry disappeared from network Dec 21 13:38:12 emilyberry volumio[1068]: info: Discovery: A device disappeared from network Dec 21 13:38:12 emilyberry sudo[3377]: pam_unix(sudo:session): session closed for user root Dec 21 13:38:12 emilyberry wireless.js[3355]: WIRELESS.JS: Stopped aP Dec 21 13:38:12 emilyberry wireless.js[3355]: WIRELESS.JS: Wireless Networking DISABLED, not starting wireless flow Dec 21 13:38:12 emilyberry wireless.js[3355]: WIRELESS.JS: Notified systemd about wireless ready Dec 21 13:38:12 emilyberry systemd[1]: Started wireless.service - Wireless Services. Dec 21 13:38:12 emilyberry sudo[3349]: pam_unix(sudo:session): session closed for user root Dec 21 13:38:15 emilyberry volumio[1068]: info: Discovery: Started advertising with name: EmilyBerry Dec 21 13:38:16 emilyberry volumio[1068]: compat.c: read() failed: Resource temporarily unavailable Dec 21 13:38:16 emilyberry volumio[1068]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 13:38:16 emilyberry volumio[1068]: Error: dns service error: unknown Dec 21 13:38:16 emilyberry volumio[1068]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 21 13:38:16 emilyberry volumio[1068]: errorCode: -65537 Dec 21 13:38:16 emilyberry volumio[1068]: } Dec 21 13:38:16 emilyberry volumio[1068]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 13:38:17 emilyberry sudo[3417]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-21 13:37' Dec 21 13:38:17 emilyberry sudo[3417]: 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"