Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 18:41:04 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:41:05 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:05 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio volumio[1301]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 22 18:41:07 volumio volumio[1301]: info: Preparing to save Alsa Options, stopping services first Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio volumio[1301]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"E70 Velvet"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 18:41:07 volumio volumio[1301]: info: Setting mixer E70 Velvet for card E70 Velvet Dec 22 18:41:07 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio vtcs[1927]: [2025-12-22 18:41:07.596] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 22 18:41:07 volumio vtcs[1927]: [2025-12-22 18:41:07.598] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 22 18:41:07 volumio volumio[1301]: info: Updating Volume Controller Parameters: Device: 5 Name: E70 Velvet Mixer: E70 Velvet Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 22 18:41:07 volumio volumio[1301]: info: Disabling external Volume Control Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:07 volumio volumio[1301]: info: Preparing to generate the ALSA configuration file Dec 22 18:41:07 volumio sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2244]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 22 18:41:07 volumio volumio[1301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 22 18:41:07 volumio volumio[1301]: info: Reading ALSA contributions from plugins. Dec 22 18:41:07 volumio sudo[2244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 22 18:41:07 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 22 18:41:07 volumio sudo[2237]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio sudo[2251]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:07 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2244]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 18:41:07 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:41:07 volumio volumio[1301]: info: VolumeController:: Volume=39 Mute =false Dec 22 18:41:07 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:07 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:07 volumio sudo[2264]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:07 volumio sudo[2264]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 22 18:41:07 volumio qobuz-connect[1834]: 20251222 18:41:07.753 [1834.1834] INFO SampleApp: Stopping Local configuration server Dec 22 18:41:07 volumio volumio[1301]: info: Asound.conf file written Dec 22 18:41:07 volumio sudo[2268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 22 18:41:07 volumio sudo[2268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2268]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio volumio[1301]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 22 18:41:07 volumio volumio[1301]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 22 18:41:07 volumio volumio[1301]: No state is present for card Velvet Dec 22 18:41:07 volumio volumio[1301]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:8750" "" "" Dec 22 18:41:07 volumio volumio[1301]: Hardware is initialized using a generic method Dec 22 18:41:07 volumio volumio[1301]: No state is present for card Velvet Dec 22 18:41:07 volumio volumio[1301]: info: Output device has changed, restarting MPD Dec 22 18:41:07 volumio volumio[1301]: info: Output device has changed, restarting Shairport Sync Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:07 volumio sudo[2275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:07 volumio sudo[2275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2276]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:07 volumio sudo[2276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2275]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio volumio[1301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 18:41:07 volumio volumio[1301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 22 18:41:07 volumio volumio[1301]: info: Output device has changed, restarting MPD Dec 22 18:41:07 volumio volumio[1301]: info: Output device has changed, restarting Shairport Sync Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:07 volumio sudo[2288]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:07 volumio sudo[2286]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio sudo[2286]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2288]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio sudo[2290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:07 volumio sudo[2290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio volumio[1301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 18:41:07 volumio volumio[1301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 volumio sudo[2286]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio sudo[2304]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio sudo[2304]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2301]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio sudo[2301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2308]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:07 volumio sudo[2308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2316]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:07 volumio sudo[2316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:07 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio sudo[2316]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:07 volumio sudo[2321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:07 volumio sudo[2321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio sudo[2329]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:07 volumio sudo[2329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:07 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio sudo[2308]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2304]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio sudo[2301]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 22 18:41:08 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 22 18:41:08 volumio sudo[2321]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 22 18:41:08 volumio volumio[1301]: info: Starting Shairport Sync Dec 22 18:41:08 volumio volumio[1301]: info: Starting Shairport Sync Dec 22 18:41:08 volumio volumio[1301]: info: Preparing to generate the ALSA configuration file Dec 22 18:41:08 volumio volumio[1301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 22 18:41:08 volumio volumio[1301]: info: Reading ALSA contributions from plugins. Dec 22 18:41:08 volumio sudo[2342]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:08 volumio sudo[2342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2345]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 18:41:08 volumio sudo[2345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio sudo[2343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 18:41:08 volumio sudo[2343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio volumio[1301]: info: Asound.conf file written Dec 22 18:41:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 22 18:41:08 volumio sudo[2352]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 22 18:41:08 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 22 18:41:08 volumio volumio[1301]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 22 18:41:08 volumio volumio[1301]: No state is present for card Velvet Dec 22 18:41:08 volumio volumio[1301]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:8750" "" "" Dec 22 18:41:08 volumio volumio[1301]: Hardware is initialized using a generic method Dec 22 18:41:08 volumio volumio[1301]: No state is present for card Velvet Dec 22 18:41:08 volumio volumio[1301]: info: Output device has changed, restarting MPD Dec 22 18:41:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 22 18:41:08 volumio volumio[1301]: info: Output device has changed, restarting Shairport Sync Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio systemd[1]: shairport-sync.service: Consumed 1.612s CPU time. Dec 22 18:41:08 volumio sudo[2360]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:08 volumio sudo[2360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2358]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:08 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 18:41:08 volumio volumio[1301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio sudo[2345]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: Preparing to generate the ALSA configuration file Dec 22 18:41:08 volumio sudo[2349]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 18:41:08 volumio sudo[2343]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:41:08 volumio sudo[2371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:08 volumio sudo[2371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2349]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2373]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:08 volumio sudo[2373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 22 18:41:08 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 22 18:41:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio volumio[1301]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 22 18:41:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 22 18:41:08 volumio volumio[1301]: info: Reading ALSA contributions from plugins. Dec 22 18:41:08 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:08 volumio volumio[1301]: info: Shairport-Sync Started Dec 22 18:41:08 volumio volumio[1301]: info: Shairport-Sync Started Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio sudo[2383]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:08 volumio sudo[2383]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2371]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: Starting Shairport Sync Dec 22 18:41:08 volumio sudo[2383]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2373]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:08 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio volumio[1301]: info: Asound.conf file unchanged, so no further update is needed Dec 22 18:41:08 volumio volumio[1301]: info: Output device has changed, restarting MPD Dec 22 18:41:08 volumio sudo[2410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 18:41:08 volumio sudo[2410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio volumio[1301]: info: Output device has changed, restarting Shairport Sync Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:08 volumio sudo[2412]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:08 volumio sudo[2415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:08 volumio sudo[2415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2412]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 22 18:41:08 volumio volumio[1301]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 18:41:08 volumio volumio[1301]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:08 volumio sudo[2426]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:08 volumio sudo[2426]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2384]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 18:41:08 volumio sudo[2384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:41:08 volumio sudo[2429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:08 volumio sudo[2429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio sudo[2384]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio sudo[2410]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:08 volumio volumio[1301]: info: Shairport-Sync Started Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio sudo[2437]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:08 volumio sudo[2437]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:08 volumio volumio[1301]: info: Starting Shairport Sync Dec 22 18:41:08 volumio sudo[2437]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2446]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 18:41:08 volumio sudo[2446]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 22 18:41:08 volumio sudo[2447]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:08 volumio sudo[2447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:08 volumio qobuz-connect[1834]: 20251222 18:41:08.514 [1834.1834] INFO SampleApp: shat down connection on UNIX socket Dec 22 18:41:08 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 22 18:41:08 volumio sudo[2426]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2429]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 22 18:41:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 22 18:41:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 22 18:41:08 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 22 18:41:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 22 18:41:08 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2264]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2447]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2342]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2329]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 22 18:41:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio volumio[1301]: info: Executing endpoint qc_getconfig Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 22 18:41:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 22 18:41:08 volumio sudo[2446]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio sudo[2467]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 18:41:08 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:41:08 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:08 volumio volumio[1301]: info: Shairport-Sync Started Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.704 [2468.2468] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 22 18:41:08 volumio volumio[1301]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.708 [2468.2468] INFO VolumeManager: [0x546da8]: Setting new playback volume: 75 Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.708 [2468.2468] INFO VolumeManager: [0x546da8]: Setting new mute state: 0 Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.708 [2468.2468] INFO QobuzConnect: [0x547778]: Client initialized! Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.708 [2468.2468] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.721 [2468.2468] INFO LocalConfigManager: [0x546688]: Starting Local Configuration server Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.721 [2468.2468] INFO SampleApp: Starting Local configuration server Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.722 [2468.2468] INFO SampleApp: Connected to UNIX socket client 0x531818 Dec 22 18:41:08 volumio qobuz-connect[2468]: 20251222 18:41:08.853 [2468.2468] INFO SampleApp: Playback volume changed: 75 Dec 22 18:41:08 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:09 volumio mpd[2474]: 2025-12-22T18:41:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 22 18:41:09 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 22 18:41:09 volumio sudo[2415]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:09 volumio sudo[2290]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:09 volumio sudo[2276]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:09 volumio sudo[2360]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:09 volumio volumio[1301]: error: MPD error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: MPD error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: MPD error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: The expression evaluated to a falsy value: Dec 22 18:41:09 volumio volumio[1301]: assert.ok(self.idling) Dec 22 18:41:09 volumio volumio[1301]: error: updateQueue error: null Dec 22 18:41:10 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:10 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:10 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:10 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:10 volumio sudo[2502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:10 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:10 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 22 18:41:10 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:10 volumio volumio[1301]: info: Executing endpoint tc_getconfig Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 22 18:41:10 volumio vtcs[2505]: STARTING TidalConnect services, version: 1.5.2.56 Dec 22 18:41:10 volumio vtcs[2505]: STARTED TidalConnect services. Dec 22 18:41:10 volumio volumio[1301]: info: Executing endpoint tc_connect Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 22 18:41:10 volumio volumio[1301]: info: Connecting to TidalConnect Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:10 volumio volumio[1301]: 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 22 18:41:10 volumio volumio[1301]: verbose: CURRENT POSITION 0 Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: info: No code Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:10 volumio volumio[1301]: 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 22 18:41:10 volumio volumio[1301]: verbose: CURRENT POSITION 0 Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: info: No code Dec 22 18:41:10 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:10 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:10 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:10 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio sudo[2534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:11 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio sudo[2534]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:11 volumio sudo[2541]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:11 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:11 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio sudo[2554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:11 volumio sudo[2554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:11 volumio sudo[2554]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:11 volumio sudo[2566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:11 volumio sudo[2566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:11 volumio sudo[2566]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 22 18:41:11 volumio volumio[1301]: info: CoreStateMachine::getcurrentVolume Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 18:41:11 volumio volumio[1301]: info: VolumeController:: Volume=39 Mute =false Dec 22 18:41:11 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:11 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:11 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:11 volumio volumio[1301]: info: CoreStateMachine::updateTrackBlock Dec 22 18:41:11 volumio volumio[1301]: info: CorePlayQueue::getTrackBlock Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 18:41:11 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:11 volumio volumio[1301]: info: VolumeController:: Volume=39 Mute =false Dec 22 18:41:11 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:11 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:11 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:11 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:11 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:12 volumio sudo[2574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:12 volumio sudo[2574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:12 volumio sudo[2576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:12 volumio sudo[2576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:12 volumio sudo[2581]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:12 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:12 volumio sudo[2582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:12 volumio sudo[2582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:12 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 22 18:41:12 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 22 18:41:12 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:12 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:12 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:12 volumio sudo[2582]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:12 volumio mpd_monitor.sh[2585]: MPD Monitor Service: Starting MPD Monitor Service Dec 22 18:41:12 volumio sudo[2576]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:12 volumio sudo[2574]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:12 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:12 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:12 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:12 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:12 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:13 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:14 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:14 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:14 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:14 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:15 volumio volumio[1301]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio sudo[2606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:15 volumio sudo[2606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:15 volumio sudo[2604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:15 volumio sudo[2604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:15 volumio sudo[2604]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:15 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:15 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 22 18:41:15 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:15 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 22 18:41:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 22 18:41:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 22 18:41:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 22 18:41:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 22 18:41:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 22 18:41:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 22 18:41:15 volumio sudo[2615]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 18:41:15 volumio sudo[2615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:41:15 volumio sudo[2615]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:16 volumio mpd[2617]: 2025-12-22T18:41:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 22 18:41:16 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 22 18:41:16 volumio sudo[2606]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:16 volumio volumio[1301]: error: updateQueue error: null Dec 22 18:41:16 volumio volumio[1301]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Dec 22 18:41:16 volumio sudo[2622]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 18:41:16 volumio sudo[2622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:16 volumio sudo[2622]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio sudo[2623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 22 18:41:16 volumio sudo[2623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:16 volumio volumio[1301]: info: MPD Permissions set Dec 22 18:41:16 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 22 18:41:16 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 22 18:41:16 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 22 18:41:16 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 22 18:41:16 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 22 18:41:16 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 22 18:41:16 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 22 18:41:16 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 22 18:41:16 volumio sudo[2632]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 18:41:16 volumio sudo[2632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:41:16 volumio sudo[2632]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:17 volumio mpd[2634]: 2025-12-22T18:41:17 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 22 18:41:17 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 22 18:41:17 volumio sudo[2623]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:17 volumio volumio[1301]: error: updateQueue error: null Dec 22 18:41:19 volumio sudo[2638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:19 volumio sudo[2638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:19 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 22 18:41:19 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 22 18:41:19 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:19 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:19 volumio sudo[2638]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:19 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:19 volumio mpd_monitor.sh[2640]: MPD Monitor Service: Starting MPD Monitor Service Dec 22 18:41:20 volumio sudo[2645]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 22 18:41:20 volumio sudo[2645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:20 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 22 18:41:20 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 22 18:41:20 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 22 18:41:20 volumio sudo[2645]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:20 volumio mpd_monitor.sh[2647]: MPD Monitor Service: Starting MPD Monitor Service Dec 22 18:41:20 volumio volumio[1301]: info: Successfully started MPD Monitor Dec 22 18:41:25 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:25 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:26 volumio volumio[1301]: info: Tunnel connection is inactive, restarting it Dec 22 18:41:26 volumio volumio[1301]: info: Starting Tunnel 1 Dec 22 18:41:26 volumio volumio[1301]: info: Starting Tunnel Connection Checker Dec 22 18:41:26 volumio sudo[2671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 22 18:41:26 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:26 volumio autossh[1866]: received signal to exit (15) Dec 22 18:41:26 volumio systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Dec 22 18:41:26 volumio systemd[1]: sshtunnel.service: Deactivated successfully. Dec 22 18:41:26 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 22 18:41:26 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 22 18:41:26 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:26 volumio volumio[1301]: info: Remote SSH Started Dec 22 18:41:26 volumio autossh[2674]: port set to 0, monitoring disabled Dec 22 18:41:26 volumio autossh[2674]: starting ssh (count 1) Dec 22 18:41:26 volumio autossh[2674]: ssh child pid is 2677 Dec 22 18:41:26 volumio volumio[1301]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 22 18:41:26 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:26 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:26 volumio volumiossh-tunnel[2677]: Warning: Permanently added '[as1.myvolumio.org]:2222' (RSA) to the list of known hosts. Dec 22 18:41:29 volumio volumio[1301]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:29 volumio volumio[1301]: info: Restoring Previous Volume level: 39 false false Dec 22 18:41:29 volumio volumio[1301]: info: Volume configurations have been set Dec 22 18:41:29 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:29 volumio vtcs[2505]: [2025-12-22 18:41:29.885] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 22 18:41:29 volumio vtcs[2505]: [2025-12-22 18:41:29.885] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 22 18:41:29 volumio sudo[2679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:29 volumio sudo[2679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 22 18:41:29 volumio volumio[1301]: info: Updating Volume Controller Parameters: Device: 5 Name: E70 Velvet Mixer: E70 Velvet Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 22 18:41:29 volumio volumio[1301]: info: Disabling external Volume Control Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:29 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 22 18:41:29 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 22 18:41:29 volumio sudo[2686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 22 18:41:29 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 22 18:41:29 volumio sudo[2686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:29 volumio sudo[2679]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:29 volumio sudo[2686]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:29 volumio sudo[2694]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 22 18:41:29 volumio sudo[2694]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 18:41:29 volumio sudo[2694]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 18:41:29 volumio sudo[2701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 22 18:41:29 volumio sudo[2701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 18:41:29 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:41:30 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 22 18:41:30 volumio volumio[1301]: info: VolumeController:: Volume=39 Mute =false Dec 22 18:41:30 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:30 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:30 volumio qobuz-connect[2468]: 20251222 18:41:30.010 [2468.2468] INFO SampleApp: Stopping Local configuration server Dec 22 18:41:30 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:30 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:30 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:30 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:30 volumio qobuz-connect[2468]: 20251222 18:41:30.745 [2468.2468] INFO SampleApp: shat down connection on UNIX socket Dec 22 18:41:30 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 22 18:41:30 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:30 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:30 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 22 18:41:30 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 22 18:41:30 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 22 18:41:30 volumio sudo[2701]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:30 volumio volumio[1301]: info: Executing endpoint qc_getconfig Dec 22 18:41:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.807 [2706.2706] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 22 18:41:30 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 22 18:41:30 volumio volumio[1301]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.809 [2706.2706] INFO VolumeManager: [0xf9da8]: Setting new playback volume: 75 Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.809 [2706.2706] INFO VolumeManager: [0xf9da8]: Setting new mute state: 0 Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.809 [2706.2706] INFO QobuzConnect: [0xfa778]: Client initialized! Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.809 [2706.2706] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.815 [2706.2706] INFO LocalConfigManager: [0xf9688]: Starting Local Configuration server Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.815 [2706.2706] INFO SampleApp: Starting Local configuration server Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.815 [2706.2706] INFO SampleApp: Connected to UNIX socket client 0xe4818 Dec 22 18:41:30 volumio qobuz-connect[2706]: 20251222 18:41:30.958 [2706.2706] INFO SampleApp: Playback volume changed: 75 Dec 22 18:41:30 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:32 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:32 volumio volumio[1301]: info: TidalConnect service stoped! Dec 22 18:41:32 volumio volumio[1301]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:32 volumio volumio[1301]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 22 18:41:32 volumio sudo[2721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 22 18:41:32 volumio sudo[2721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:33 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 22 18:41:33 volumio sudo[2721]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:33 volumio volumio[1301]: info: Executing endpoint tc_getconfig Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 22 18:41:33 volumio vtcs[2724]: STARTING TidalConnect services, version: 1.5.2.56 Dec 22 18:41:33 volumio vtcs[2724]: STARTED TidalConnect services. Dec 22 18:41:33 volumio volumio[1301]: info: Executing endpoint tc_connect Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 22 18:41:33 volumio volumio[1301]: info: Connecting to TidalConnect Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:33 volumio volumio[1301]: 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 22 18:41:33 volumio volumio[1301]: verbose: CURRENT POSITION 0 Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: info: No code Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::servicePushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:33 volumio volumio[1301]: 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 22 18:41:33 volumio volumio[1301]: verbose: CURRENT POSITION 0 Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::syncState stateService stop Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::syncState currentStatus stop Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: info: No code Dec 22 18:41:33 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:33 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:33 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:33 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:34 volumio volumio[1301]: info: VolumeController::SetAlsaVolume39 Dec 22 18:41:34 volumio volumio[1301]: info: CoreStateMachine::pushState Dec 22 18:41:34 volumio volumio[1301]: info: CoreCommandRouter::volumioPushState Dec 22 18:41:34 volumio volumio[1301]: info: MRS: Pushing multiroomSync output update for this device Dec 22 18:41:34 volumio volumio[1301]: info: MRS: Pushing multiroomSync output Dec 22 18:41:34 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:34 volumio volumio[1301]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.n7aAtfvzGtQfTecd4mOmdJuLYDZ2.dbb99c7eb79a0c24493abf5fcfcf00e5.state.status' Dec 22 18:41:35 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:35 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:36 volumio volumio[1301]: info: TidalConnect service started! Dec 22 18:41:41 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:43 volumio volumio[1301]: info: Executing endpoint metavolumio Dec 22 18:41:43 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: Retrieving Cloud Streaming UI Dec 22 18:41:44 volumio volumio[1301]: info: Getting Tidal Cloud Configuration Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: Getting Qobuz Cloud Configuration Dec 22 18:41:44 volumio volumio[1301]: info: Asking plugin for UI Config Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: Getting Spotify Cloud Configuration Dec 22 18:41:44 volumio volumio[1301]: info: Asking plugin for UI Config Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: Saving Spotify Acccount Dec 22 18:41:44 volumio volumio[1301]: info: Got it Dec 22 18:41:44 volumio volumio[1301]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 22 18:41:44 volumio volumio[1301]: info: Got it Dec 22 18:41:44 volumio volumio[1301]: info: Got Tidal Cloud Configuration Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:41:44 volumio volumio[1301]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:41:45 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:41:45 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 22 18:41:45 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:45 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:41:53 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:41:53 volumio volumio[1301]: info: Disabling MyMusic plugin qobuzconnect Dec 22 18:41:53 volumio volumio[1301]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service qobuzconnect Dec 22 18:41:53 volumio qobuz-connect[2706]: 20251222 18:41:53.061 [2706.2706] INFO MediaEngine: [0xf9940]: Stopping playback, keeping tracks Dec 22 18:41:53 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:53 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:53 volumio sudo[2778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect Dec 22 18:41:53 volumio sudo[2778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:41:53 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 22 18:41:53 volumio qobuz-connect[2706]: 20251222 18:41:53.085 [2706.2706] INFO SampleApp: Stopping Local configuration server Dec 22 18:41:54 volumio qobuz-connect[2706]: 20251222 18:41:54.849 [2706.2706] INFO SampleApp: shat down connection on UNIX socket Dec 22 18:41:54 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 22 18:41:54 volumio volumio[1301]: info: QobuzConnect: setDeactiveState invoked Dec 22 18:41:54 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:54 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 22 18:41:54 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 22 18:41:54 volumio sudo[2778]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:54 volumio volumio[1301]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket disconnected and tore down Dec 22 18:41:54 volumio volumio[1301]: info: Disabling plugin qobuzconnect Dec 22 18:41:55 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:55 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:55 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:55 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:55 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:55 volumio volumio[1301]: info: Listing playlists Dec 22 18:41:57 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:41:58 volumio volumio[1301]: info: Disabling MyMusic plugin smart_inputs Dec 22 18:41:58 volumio volumio[1301]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Dec 22 18:41:58 volumio volumio[1301]: info: Removeing all smart Inputs Dec 22 18:41:58 volumio volumio[1301]: info: Disabling plugin smart_inputs Dec 22 18:41:59 volumio volumio[1301]: info: Disabling MyMusic plugin cd_controller Dec 22 18:41:59 volumio volumio[1301]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Dec 22 18:41:59 volumio volumio[1301]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Dec 22 18:41:59 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 18:41:59 volumio volumio[1301]: Cannot find translation for source TIDAL Dec 22 18:41:59 volumio volumio[1301]: info: Stopping UDEV Watcher for CD Dec 22 18:41:59 volumio volumio[1301]: info: Disabling plugin cd_controller Dec 22 18:42:01 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:05 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:05 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:05 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:09 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:13 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:15 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:15 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:15 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:17 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:21 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:25 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:25 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:25 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:26 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:28 volumio volumio[1301]: info: Executing endpoint metavolumio Dec 22 18:42:28 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 22 18:42:30 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:42:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 22 18:42:30 volumio sudo[2851]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 22 18:42:30 volumio sudo[2851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2855]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:30 volumio sudo[2855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2855]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2863]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:30 volumio sudo[2863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2851]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2863]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2868]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:30 volumio sudo[2868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2873]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:42:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 22 18:42:30 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 22 18:42:30 volumio sudo[2873]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2868]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2873]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2877]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:42:30 volumio sudo[2877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:30 volumio sudo[2877]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:30 volumio sudo[2882]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 22 18:42:30 volumio sudo[2882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:31 volumio sudo[2882]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:35 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:35 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:35 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:36 volumio volumio[1301]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 22 18:42:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 22 18:42:36 volumio sudo[2900]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 22 18:42:36 volumio sudo[2900]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:36 volumio sudo[2900]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:36 volumio sudo[2902]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 22 18:42:36 volumio sudo[2902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:36 volumio sudo[2902]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:36 volumio volumio[1301]: info: Permissions for /etc/network/interfaces set Dec 22 18:42:36 volumio volumio[1301]: info: Restarting Wireless Network Dec 22 18:42:36 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 22 18:42:36 volumio volumio[1301]: info: Discovery: Restarting Advertising due to device name change Dec 22 18:42:36 volumio sudo[2905]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 22 18:42:36 volumio sudo[2905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:36 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 22 18:42:37 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 22 18:42:37 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 22 18:42:37 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 22 18:42:37 volumio wireless.js[2909]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 22 18:42:37 volumio wireless.js[2909]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 22 18:42:37 volumio wireless.js[2909]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 22 18:42:37 volumio wireless.js[2909]: WIRELESS.JS: Cleaning previous... Dec 22 18:42:37 volumio sudo[2928]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 22 18:42:37 volumio sudo[2928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:42:37 volumio sudo[2928]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:37 volumio sudo[2930]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 22 18:42:37 volumio sudo[2930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:42:37 volumio sudo[2930]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:37 volumio wireless.js[2909]: WIRELESS.JS: Stopped aP Dec 22 18:42:37 volumio sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 22 18:42:37 volumio sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:37 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 22 18:42:37 volumio sudo[2938]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:37 volumio sudo[2940]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 22 18:42:37 volumio sudo[2940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:37 volumio sudo[2940]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:37 volumio sudo[2948]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 22 18:42:37 volumio sudo[2948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:37 volumio sudo[2948]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:37 volumio sudo[2950]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 22 18:42:37 volumio sudo[2950]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:37 volumio volumio[1301]: info: Discovery: A device disappeared from network Dec 22 18:42:37 volumio volumio[1301]: info: Discovery: Device volumio disappeared from network Dec 22 18:42:37 volumio volumio[1301]: info: Discovery: A device disappeared from network Dec 22 18:42:38 volumio sudo[2950]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:38 volumio wireless.js[2909]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: CN Dec 22 18:42:38 volumio sudo[2956]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 22 18:42:38 volumio sudo[2956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:38 volumio sudo[2956]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:38 volumio sudo[2958]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Dec 22 18:42:38 volumio sudo[2958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:38 volumio sudo[2958]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:38 volumio wireless.js[2909]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: CN Dec 22 18:42:38 volumio wireless.js[2909]: WIRELESS.JS: Wireless Networking DISABLED, not starting wireless flow Dec 22 18:42:39 volumio wireless.js[2909]: WIRELESS.JS: Notified systemd about wireless ready Dec 22 18:42:39 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 22 18:42:39 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 22 18:42:39 volumio sudo[2905]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:41 volumio volumio[1301]: info: Discovery: Started advertising with name: Volumio Dec 22 18:42:42 volumio volumio[1301]: info: Discovery: adding 5b2300d6-1e0c-4029-9307-6cf2d0af1a68 Dec 22 18:42:42 volumio volumio[1301]: info: Discovery: Found device Volumio Dec 22 18:42:42 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:42 volumio volumio[1301]: info: Discovery: this is already registered, 5b2300d6-1e0c-4029-9307-6cf2d0af1a68 Dec 22 18:42:42 volumio volumio[1301]: info: Discovery: Found device Volumio Dec 22 18:42:42 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Dec 22 18:42:44 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Dec 22 18:42:44 volumio sudo[2986]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:42:44 volumio sudo[2986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:44 volumio sudo[2986]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:45 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:45 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:48 volumio volumio[1301]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object] Dec 22 18:42:48 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Dec 22 18:42:49 volumio volumio[1301]: info: Refreshing Cached IP Addresses Dec 22 18:42:49 volumio sudo[2990]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Dec 22 18:42:49 volumio sudo[2990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[2992]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:42:49 volumio sudo[2992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[2995]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:42:49 volumio sudo[2992]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[2995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[2990]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[2995]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[2999]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:42:49 volumio sudo[2999]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[2999]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3001]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:42:49 volumio sudo[3001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3001]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio volumio[1301]: verbose: New Socket.io Connection to 192.168.1.170 from 192.168.1.90 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Dec 22 18:42:49 volumio sudo[3005]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Dec 22 18:42:49 volumio sudo[3005]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3005]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio volumio[1301]: info: Permissions for /etc/hostapd/hostapd.conf Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 22 18:42:49 volumio volumio[1301]: info: Discovery: Restarting Advertising due to device name change Dec 22 18:42:49 volumio sudo[3008]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 22 18:42:49 volumio sudo[3008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 22 18:42:49 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 22 18:42:49 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 22 18:42:49 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::volumioGetVisibleSources Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 22 18:42:49 volumio volumio[1301]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 22 18:42:49 volumio volumio[1301]: info: Received Get System Info Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:42:49 volumio volumio[1301]: info: Discovery: Getting this device information Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:49 volumio volumio[1301]: info: Listing playlists Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 22 18:42:49 volumio sudo[3030]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:49 volumio sudo[3030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3025]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 22 18:42:49 volumio sudo[3036]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:49 volumio sudo[3025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3030]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3036]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3044]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:42:49 volumio sudo[3048]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:42:49 volumio sudo[3048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3048]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 22 18:42:49 volumio sudo[3044]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3053]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:42:49 volumio sudo[3053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 22 18:42:49 volumio sudo[3053]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3025]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 22 18:42:49 volumio wireless.js[3011]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 22 18:42:49 volumio wireless.js[3011]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 22 18:42:49 volumio wireless.js[3011]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 22 18:42:49 volumio wireless.js[3011]: WIRELESS.JS: Cleaning previous... Dec 22 18:42:49 volumio sudo[3064]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 22 18:42:49 volumio sudo[3064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:42:49 volumio sudo[3064]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:49 volumio sudo[3066]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 22 18:42:49 volumio sudo[3066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 22 18:42:50 volumio sudo[3066]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:50 volumio wireless.js[3011]: WIRELESS.JS: Stopped aP Dec 22 18:42:50 volumio wireless.js[3011]: WIRELESS.JS: Wireless Networking DISABLED, not starting wireless flow Dec 22 18:42:50 volumio volumio[1301]: info: Discovery: A device disappeared from network Dec 22 18:42:50 volumio volumio[1301]: info: Discovery: Device volumio disappeared from network Dec 22 18:42:50 volumio volumio[1301]: info: Discovery: A device disappeared from network Dec 22 18:42:50 volumio wireless.js[3011]: WIRELESS.JS: Notified systemd about wireless ready Dec 22 18:42:50 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 22 18:42:50 volumio sudo[3008]: pam_unix(sudo:session): session closed for user root Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:42:51 volumio volumio[1301]: info: Received Get System Info Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:42:51 volumio volumio[1301]: info: Discovery: Getting this device information Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:51 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:42:52 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:42:52 volumio volumio[1301]: info: Received Get System Info Dec 22 18:42:52 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:42:52 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:42:52 volumio volumio[1301]: info: Discovery: Getting this device information Dec 22 18:42:52 volumio volumio[1301]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:52 volumio volumio[1301]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:42:54 volumio volumio[1301]: info: Discovery: Started advertising with name: Volumio Dec 22 18:42:55 volumio volumio[1301]: compat.c: read() failed: Resource temporarily unavailable Dec 22 18:42:55 volumio volumio[1301]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 18:42:55 volumio volumio[1301]: Error: dns service error: unknown Dec 22 18:42:55 volumio volumio[1301]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 22 18:42:55 volumio volumio[1301]: errorCode: -65537 Dec 22 18:42:55 volumio volumio[1301]: } Dec 22 18:42:55 volumio volumio[1301]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 18:42:55 volumio sudo[3105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-22 18:41' Dec 22 18:42:55 volumio sudo[3105]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"