-- Logs begin at Mon 2026-01-12 16:03:34 ACDT, end at Mon 2026-01-12 16:39:13 ACDT. -- Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:00 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:00 lounge volumio[3317]: verbose: New Socket.io Connection to 192.168.50.143:3000 from 192.168.50.109 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:38:00 lounge volumio[3317]: info: CoreCommandRouter::volumioPause Jan 12 16:38:00 lounge volumio[3317]: info: CoreStateMachine::pause Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:38:04 lounge volumio[3317]: No protocol specified Jan 12 16:38:04 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 12 16:38:04 lounge volumio[3317]: No protocol specified Jan 12 16:38:04 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:04 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:06 lounge volumio[3317]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 12 16:38:06 lounge volumio[3317]: info: Preparing to save Alsa Options, stopping services first Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioPause Jan 12 16:38:06 lounge volumio[3317]: info: CoreStateMachine::pause Jan 12 16:38:06 lounge volumio[3317]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"peachtree USB Audio 2.0"}} Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 12 16:38:06 lounge volumio[3317]: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge volumio[3317]: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 12 16:38:06 lounge volumio[3317]: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge volumio[3317]: info: Setting default mixerSoftMaster for Softvolume device Jan 12 16:38:06 lounge volumio[3317]: info: QobuzConnect: setDeactiveState invoked Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:06 lounge volumio[3317]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jan 12 16:38:06 lounge vtcs[8577]: [2026-01-12 16:38:06.485] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 12 16:38:06 lounge vtcs[8577]: [2026-01-12 16:38:06.487] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=7 errorno=104 error=Connection reset by peer Jan 12 16:38:06 lounge vtcs[8577]: [2026-01-12 16:38:06.487] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 12 16:38:06 lounge sudo[11955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:06 lounge sudo[11955]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:06 lounge systemd[1]: Stopping Volumio Tidal Connect Service... Jan 12 16:38:06 lounge systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jan 12 16:38:06 lounge systemd[1]: vtcs.service: Succeeded. Jan 12 16:38:06 lounge systemd[1]: Stopped Volumio Tidal Connect Service. Jan 12 16:38:06 lounge sudo[11955]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:06 lounge volumio[3317]: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 12 16:38:06 lounge volumio[3317]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 12 16:38:06 lounge volumio[3317]: info: Disabling external Volume Control Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:38:06 lounge volumio[3317]: info: Enable softmixer device for audio device undefined Jan 12 16:38:06 lounge sudo[11969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:06 lounge sudo[11969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:06 lounge sudo[11969]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:06 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:06 lounge sudo[11977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 16:38:06 lounge sudo[11977]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:06 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:06 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:06 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:06 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:06.830+10:30 level=ERROR msg="failed to unmarshal pushState event" component=volumio/socket error="json: cannot unmarshal string into Go struct field State.volume of type int" Jan 12 16:38:06 lounge volumio[3317]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge sudo[11977]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:06 lounge volumio[3317]: info: Software Volume ALSA configuration written Jan 12 16:38:06 lounge volumio[3317]: info: Preparing to generate the ALSA configuration file Jan 12 16:38:06 lounge sudo[11979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 16:38:06 lounge sudo[11979]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:06 lounge systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 12 16:38:06 lounge qobuz-connect[8499]: 20260112 16:38:06.955 [8499.8499] INFO SampleApp: Stopping Local configuration server Jan 12 16:38:06 lounge qobuz-connect[8499]: 20260112 16:38:06.966 [8499.8499] INFO SampleApp: shat down connection on UNIX socket Jan 12 16:38:06 lounge volumio[3317]: No protocol specified Jan 12 16:38:06 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:06 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 12 16:38:07 lounge systemd[1]: qobuz-connect.service: Succeeded. Jan 12 16:38:07 lounge systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 12 16:38:07 lounge systemd[1]: Started Volumio Qobuz Connect Service. Jan 12 16:38:07 lounge sudo[11979]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:07 lounge volumio[3317]: No protocol specified Jan 12 16:38:07 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jan 12 16:38:07 lounge volumio[3317]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 12 16:38:07 lounge volumio[3317]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 12 16:38:07 lounge volumio[3317]: info: Reading ALSA contributions from plugins. Jan 12 16:38:07 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:07 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 12 16:38:07 lounge volumio[3317]: info: QobuzConnect: setDeactiveState invoked Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:07 lounge volumio[3317]: info: Executing endpoint qc_getconfig Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.225 [11986.11986] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 12 16:38:07 lounge volumio[3317]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 12 16:38:07 lounge volumio[3317]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.240 [11986.11986] INFO VolumeManager: [0xac9e77f0]: Setting new playback volume: 75 Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.240 [11986.11986] INFO VolumeManager: [0xac9e77f0]: Setting new mute state: 0 Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.240 [11986.11986] INFO QobuzConnect: [0xac9e81c0]: Client initialized! Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.240 [11986.11986] INFO SampleApp: Starting Avahi advertising, name: Lounge, service name: _qobuz-connect._tcp Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.255 [11986.11986] INFO LocalConfigManager: [0xac9e70d0]: Starting Local Configuration server Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.255 [11986.11986] INFO SampleApp: Starting Local configuration server Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.256 [11986.11986] INFO SampleApp: Connected to UNIX socket client 0xac9dced8 Jan 12 16:38:07 lounge volumio[3317]: No protocol specified Jan 12 16:38:07 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:07 lounge qobuz-connect[11986]: 20260112 16:38:07.376 [11986.11986] INFO SampleApp: Playback volume changed: 75 Jan 12 16:38:07 lounge sudo[12006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jan 12 16:38:07 lounge sudo[12006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:07 lounge volumio[3317]: info: Asound.conf file unchanged, so no further update is needed Jan 12 16:38:07 lounge volumio[3317]: info: Output device has changed, restarting MPD Jan 12 16:38:07 lounge sudo[12006]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:07 lounge sudo[12009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 12 16:38:07 lounge sudo[12009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:07 lounge sudo[12010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 12 16:38:07 lounge sudo[12010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:07 lounge systemd[1]: Stopping RAAT DAEMON... Jan 12 16:38:07 lounge volumio[3317]: info: Output device has changed, restarting Shairport Sync Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:07 lounge systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jan 12 16:38:07 lounge systemd[1]: raat-daemon.service: Succeeded. Jan 12 16:38:07 lounge systemd[1]: Stopped RAAT DAEMON. Jan 12 16:38:07 lounge sudo[12010]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:07 lounge systemd[1]: Started RAAT DAEMON. Jan 12 16:38:07 lounge sudo[12009]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:07 lounge sudo[12014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 12 16:38:07 lounge sudo[12014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:07 lounge systemd[1]: Stopping Music Player Daemon... Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:09 lounge volumio[3317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: setDeactiveState invoked Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge volumio[3317]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 12 16:38:09 lounge volumio[3317]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jan 12 16:38:09 lounge volumio[3317]: info: MPD Permissions set Jan 12 16:38:09 lounge volumio[3317]: info: Raat Daemon started successfully Jan 12 16:38:09 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:07 lounge sudo[12029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:09 lounge systemd[1]: mpd.service: Succeeded. Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: Starting Shairport Sync Jan 12 16:38:09 lounge volumio[3317]: info: Preparing to generate the ALSA configuration file Jan 12 16:38:09 lounge volumio[3317]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 12 16:38:09 lounge volumio[3317]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 12 16:38:09 lounge volumio[3317]: info: Reading ALSA contributions from plugins. Jan 12 16:38:09 lounge volumio[3317]: info: Asound.conf file unchanged, so no further update is needed Jan 12 16:38:09 lounge volumio[3317]: info: Output device has changed, restarting MPD Jan 12 16:38:09 lounge volumio[3317]: info: Output device has changed, restarting Shairport Sync Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:09 lounge volumio[3317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: setDeactiveState invoked Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge volumio[3317]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:07 lounge sudo[12029]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge systemd[1]: Stopped Music Player Daemon. Jan 12 16:38:09 lounge volumio[3317]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jan 12 16:38:09 lounge volumio[3317]: info: MPD Permissions set Jan 12 16:38:09 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:09 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:09 lounge volumio[3317]: info: Starting Shairport Sync Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:07 lounge sudo[12029]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 12 16:38:09 lounge volumio[3317]: No protocol specified Jan 12 16:38:09 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:38:07 lounge sudo[12033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:07 lounge sudo[12033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:07 lounge sudo[12033]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:07 lounge sudo[12041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 16:38:07 lounge sudo[12041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge volumio[3317]: info: Executing endpoint restartRAATSocket Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jan 12 16:38:08 lounge sudo[12050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 12 16:38:08 lounge sudo[12050]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 12 16:38:08 lounge sudo[12053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12053]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:08 lounge sudo[12056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 12 16:38:08 lounge sudo[12056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:08 lounge sudo[12064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 12 16:38:08 lounge sudo[12068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 12 16:38:08 lounge sudo[12074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jan 12 16:38:08 lounge sudo[12089]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 12 16:38:08 lounge sudo[12092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:08 lounge sudo[12101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jan 12 16:38:08 lounge sudo[12101]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge sudo[12041]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 16:38:09 lounge sudo[12108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge volumio[3317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jan 12 16:38:09 lounge sudo[12074]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12089]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge sudo[12101]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 12 16:38:09 lounge sudo[12112]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge qobuz-connect[11986]: 20260112 16:38:09.298 [11986.11986] INFO SampleApp: Stopping Local configuration server Jan 12 16:38:09 lounge systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 12 16:38:09 lounge systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 12 16:38:09 lounge qobuz-connect[11986]: 20260112 16:38:09.311 [11986.11986] INFO SampleApp: shat down connection on UNIX socket Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: setDeactiveState invoked Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge sudo[12113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 12 16:38:09 lounge sudo[12113]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge systemd[1]: Starting Music Player Daemon... Jan 12 16:38:09 lounge sudo[12114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 12 16:38:09 lounge sudo[12114]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge systemd[1]: shairport-sync.service: Succeeded. Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 12 16:38:09 lounge systemd[1]: qobuz-connect.service: Succeeded. Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge sudo[12064]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12068]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge systemd[1]: Stopping RAAT DAEMON... Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge systemd[1]: Started Volumio Qobuz Connect Service. Jan 12 16:38:09 lounge sudo[12112]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12108]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 12 16:38:09 lounge sudo[12116]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 12 16:38:09 lounge sudo[12116]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge sudo[12050]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12092]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:09 lounge systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jan 12 16:38:09 lounge systemd[1]: raat-daemon.service: Succeeded. Jan 12 16:38:09 lounge systemd[1]: Stopped RAAT DAEMON. Jan 12 16:38:09 lounge volumio[3317]: info: Shairport-Sync Started Jan 12 16:38:09 lounge volumio[3317]: (node:3317) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 12 16:38:09 lounge volumio[3317]: (node:3317) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 12 16:38:09 lounge volumio[3317]: (node:3317) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 12 16:38:09 lounge volumio[3317]: (node:3317) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 12 16:38:09 lounge volumio[3317]: (node:3317) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 12 16:38:09 lounge volumio[3317]: info: Shairport-Sync Started Jan 12 16:38:09 lounge sudo[12116]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:09 lounge volumio[3317]: info: Executing endpoint qc_getconfig Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 12 16:38:09 lounge systemd[1]: Started RAAT DAEMON. Jan 12 16:38:09 lounge sudo[12114]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge sudo[12113]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.689 [12122.12122] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 12 16:38:09 lounge volumio[3317]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.703 [12122.12122] INFO VolumeManager: [0xac0457f0]: Setting new playback volume: 75 Jan 12 16:38:09 lounge volumio[3317]: info: Raat Daemon started successfully Jan 12 16:38:09 lounge volumio[3317]: info: Raat Daemon started successfully Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.704 [12122.12122] INFO VolumeManager: [0xac0457f0]: Setting new mute state: 0 Jan 12 16:38:09 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.706 [12122.12122] INFO QobuzConnect: [0xac0461c0]: Client initialized! Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.706 [12122.12122] INFO SampleApp: Starting Avahi advertising, name: Lounge, service name: _qobuz-connect._tcp Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.720 [12122.12122] INFO LocalConfigManager: [0xac0450d0]: Starting Local Configuration server Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.720 [12122.12122] INFO SampleApp: Starting Local configuration server Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.721 [12122.12122] INFO SampleApp: Connected to UNIX socket client 0xac03aed8 Jan 12 16:38:09 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:09 lounge qobuz-connect[12122]: 20260112 16:38:09.839 [12122.12122] INFO SampleApp: Playback volume changed: 75 Jan 12 16:38:09 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:09 lounge volumio[3317]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:09 lounge volumio[3317]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:09 lounge sudo[12150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 12 16:38:09 lounge sudo[12150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:09 lounge systemd[1]: Started Volumio Tidal Connect Service. Jan 12 16:38:09 lounge sudo[12150]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:10 lounge volumio[3317]: info: RAAT: Requesting Headphone Status Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jan 12 16:38:10 lounge volumio[3317]: info: MCU Signalled Headphone Mode Disabled Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jan 12 16:38:10 lounge volumio[3317]: info: Reporting Headphone State: false Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:10 lounge volumio[3317]: info: Updating RAAT Signal Path Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 12 16:38:10 lounge volumio[3317]: info: CoreStateMachine::getcurrentVolume Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioRetrievevolume Jan 12 16:38:10 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:10 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:10 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:10 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:10 lounge volumio[3317]: info: CoreStateMachine::updateTrackBlock Jan 12 16:38:10 lounge volumio[3317]: info: CorePlayQueue::getTrackBlock Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioRetrievevolume Jan 12 16:38:10 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:10.776+10:30 level=ERROR msg="failed to unmarshal pushState event" component=volumio/socket error="json: cannot unmarshal string into Go struct field State.volume of type int" Jan 12 16:38:10 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:10 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:10 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:10 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:10 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:10 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:10.875+10:30 level=ERROR msg="failed to unmarshal pushState event" component=volumio/socket error="json: cannot unmarshal string into Go struct field State.volume of type int" Jan 12 16:38:10 lounge volumio[3317]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:10 lounge volumio[3317]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:10 lounge sudo[12176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 12 16:38:10 lounge sudo[12176]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:11 lounge sudo[12176]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:11 lounge volumio[3317]: info: Executing endpoint restartRAATSocket Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jan 12 16:38:11 lounge volumio[3317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jan 12 16:38:11 lounge volumio[3317]: info: Executing endpoint tc_getconfig Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 12 16:38:11 lounge vtcs[12152]: STARTING TidalConnect services, version: 1.5.2.56 Jan 12 16:38:11 lounge vtcs[12152]: STARTED TidalConnect services. Jan 12 16:38:11 lounge volumio[3317]: info: Executing endpoint tc_connect Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 12 16:38:11 lounge volumio[3317]: info: Connecting to TidalConnect Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::servicePushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:11 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:11 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:11 lounge volumio[3317]: info: CorePlayQueue::getTrack 3 Jan 12 16:38:11 lounge volumio[3317]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::servicePushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreStateMachine::pushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::volumioPushState Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:11 lounge volumio[3317]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:38:11 lounge volumio[3317]: info: MRS: Pushing multiroomSync output Jan 12 16:38:11 lounge volumio[3317]: info: CorePlayQueue::getTrack 3 Jan 12 16:38:11 lounge volumio[3317]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Jan 12 16:38:11 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:11.424+10:30 level=ERROR msg="failed to unmarshal pushState event" component=volumio/socket error="json: cannot unmarshal string into Go struct field State.volume of type int" Jan 12 16:38:11 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:11.427+10:30 level=ERROR msg="failed to unmarshal pushState event" component=volumio/socket error="json: cannot unmarshal string into Go struct field State.volume of type int" Jan 12 16:38:11 lounge volumio[3317]: info: RAAT: Requesting Headphone Status Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jan 12 16:38:11 lounge volumio[3317]: info: MCU Signalled Headphone Mode Disabled Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jan 12 16:38:11 lounge volumio[3317]: info: Reporting Headphone State: false Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:11 lounge volumio[3317]: info: Updating RAAT Signal Path Jan 12 16:38:11 lounge mpd[12131]: Jan 12 16:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 12 16:38:11 lounge systemd[1]: Started Music Player Daemon. Jan 12 16:38:11 lounge sudo[12056]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:11 lounge sudo[12014]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:11 lounge volumio[3317]: error: MPD error: The expression evaluated to a falsy value: Jan 12 16:38:11 lounge volumio[3317]: assert.ok(self.idling) Jan 12 16:38:11 lounge volumio[3317]: error: The expression evaluated to a falsy value: Jan 12 16:38:11 lounge volumio[3317]: assert.ok(self.idling) Jan 12 16:38:11 lounge volumio[3317]: error: updateQueue error: null Jan 12 16:38:11 lounge volumio[3317]: info: RAAT: Requesting Headphone Status Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jan 12 16:38:11 lounge volumio[3317]: info: MCU Signalled Headphone Mode Disabled Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jan 12 16:38:11 lounge volumio[3317]: info: Reporting Headphone State: false Jan 12 16:38:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 12 16:38:11 lounge volumio[3317]: info: Updating RAAT Signal Path Jan 12 16:38:12 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:12 lounge volumio[3317]: info: TidalConnect service stoped! Jan 12 16:38:12 lounge volumio[3317]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:12 lounge volumio[3317]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 12 16:38:12 lounge sudo[12212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 12 16:38:12 lounge sudo[12212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:12 lounge sudo[12212]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:12 lounge volumio[3317]: info: TidalConnect service started! Jan 12 16:38:14 lounge volumio[3317]: info: TidalConnect service started! Jan 12 16:38:14 lounge sudo[12217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 12 16:38:14 lounge sudo[12217]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:14 lounge sudo[12220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 12 16:38:14 lounge systemd[1]: Stopping MPD Monitor Service... Jan 12 16:38:14 lounge systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 12 16:38:14 lounge sudo[12220]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:14 lounge systemd[1]: mpd_monitor.service: Succeeded. Jan 12 16:38:14 lounge systemd[1]: Stopped MPD Monitor Service. Jan 12 16:38:14 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:14 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:14 lounge systemd[1]: Started MPD Monitor Service. Jan 12 16:38:14 lounge sudo[12217]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:14 lounge volumio[3317]: info: Successfully started MPD Monitor Jan 12 16:38:14 lounge systemd[1]: Stopping MPD Monitor Service... Jan 12 16:38:14 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:38:14 lounge systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 12 16:38:14 lounge systemd[1]: mpd_monitor.service: Succeeded. Jan 12 16:38:14 lounge systemd[1]: Stopped MPD Monitor Service. Jan 12 16:38:14 lounge volumio[3317]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 12 16:38:14 lounge systemd[1]: Started MPD Monitor Service. Jan 12 16:38:14 lounge sudo[12220]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:14 lounge volumio[3317]: info: Successfully started MPD Monitor Jan 12 16:38:14 lounge mpd_monitor.sh[12230]: MPD Monitor Service: Starting MPD Monitor Service Jan 12 16:38:15 lounge volumio[3317]: info: TidalConnect service started! Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:38:16 lounge volumio[3317]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 12 16:38:16 lounge volumio[3317]: info: Received Get System Version Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:38:16 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:16 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:16 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:23 lounge volumio5-onboarding[3825]: time=2026-01-12T16:38:23.644+10:30 level=INFO msg="new address was allocated" component=conn/ble old=9 new=10 Jan 12 16:38:23 lounge sudo[12253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:38:23 lounge sudo[12253]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:23 lounge sudo[12253]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:23 lounge sudo[12257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:38:23 lounge sudo[12257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:23 lounge sudo[12257]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:23 lounge volumio[3317]: verbose: New Socket.io Connection to 192.168.50.143 from 192.168.50.109 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.147 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 12 16:38:23 lounge dbus-daemon[2835]: [system] Rejected send message, 1 matched rules; type="error", sender=":1.17" (uid=0 pid=3825 comm="/usr/bin/volumio5-onboarding " label="kernel") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.5" (uid=0 pid=3209 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap,hostn" label="kernel") Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:38:23 lounge volumio[3317]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:38:23 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:23 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:23 lounge volumio[3317]: info: Listing playlists Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jan 12 16:38:23 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:38:24 lounge volumio[3317]: info: Received Get System Version Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:38:24 lounge sudo[12261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:38:24 lounge sudo[12261]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:24 lounge sudo[12261]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:24 lounge sudo[12264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:38:24 lounge sudo[12264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:38:24 lounge sudo[12264]: pam_unix(sudo:session): session closed for user root Jan 12 16:38:24 lounge volumio[3317]: verbose: New Socket.io Connection to 192.168.50.143 from 192.168.50.109 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.147 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:38:24 lounge volumio[3317]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:38:24 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:24 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:24 lounge volumio[3317]: info: Listing playlists Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:38:24 lounge volumio[3317]: info: Received Get System Version Jan 12 16:38:24 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 16:38:25 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:25 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 12 16:38:25 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 16:38:26 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:26 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:38:26 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 12 16:38:27 lounge volumio[3317]: info: CoreCommandRouter::volumioPause Jan 12 16:38:27 lounge volumio[3317]: info: CoreStateMachine::pause Jan 12 16:38:28 lounge volumio[3317]: info: CoreCommandRouter::volumioPause Jan 12 16:38:28 lounge volumio[3317]: info: CoreStateMachine::pause Jan 12 16:38:34 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:38:42 lounge volumio[3317]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 12 16:38:42 lounge volumio[3317]: info: Received Get System Version Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:38:42 lounge volumio[3317]: info: Received Get System Info Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:38:42 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:38:42 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:39:03 lounge sudo[12390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:39:03 lounge sudo[12390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:39:03 lounge sudo[12390]: pam_unix(sudo:session): session closed for user root Jan 12 16:39:03 lounge sudo[12394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:39:03 lounge sudo[12394]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:39:03 lounge sudo[12394]: pam_unix(sudo:session): session closed for user root Jan 12 16:39:03 lounge volumio[3317]: verbose: New Socket.io Connection to 192.168.50.143 from 192.168.50.109 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.147 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:39:03 lounge volumio[3317]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:39:03 lounge volumio[3317]: info: Received Get System Info Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:39:03 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:39:03 lounge volumio[3317]: info: Listing playlists Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 16:39:03 lounge volumio[3317]: info: Received Get System Version Jan 12 16:39:03 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 12 16:39:05 lounge volumio[3317]: info: Received Get System Info Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:39:05 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:39:05 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 12 16:39:10 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Jan 12 16:39:10 lounge volumio[3317]: info: CoreCommandRouter::Reload Ui Jan 12 16:39:11 lounge sudo[12415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:39:11 lounge sudo[12415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:39:11 lounge sudo[12415]: pam_unix(sudo:session): session closed for user root Jan 12 16:39:11 lounge sudo[12419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:39:11 lounge sudo[12419]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:39:11 lounge sudo[12419]: pam_unix(sudo:session): session closed for user root Jan 12 16:39:11 lounge volumio[3317]: verbose: New Socket.io Connection to 192.168.50.143 from 192.168.50.109 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.147 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jan 12 16:39:11 lounge volumio[3317]: No protocol specified Jan 12 16:39:11 lounge volumio[3317]: xcb_connection_has_error() returned true Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jan 12 16:39:11 lounge volumio[3317]: info: Received Get System Info Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:39:11 lounge volumio[3317]: info: Discovery: Getting this device information Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::volumioGetState Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:39:11 lounge volumio-remote-updater[2843]: No test mode Jan 12 16:39:11 lounge volumio-remote-updater[2843]: No alpha test mode Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:11 lounge volumio[3317]: info: Retrieving Cloud Streaming UI Jan 12 16:39:11 lounge volumio[3317]: info: Getting Tidal Cloud Configuration Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:11 lounge volumio[3317]: info: Getting Qobuz Cloud Configuration Jan 12 16:39:11 lounge volumio[3317]: info: Asking plugin for UI Config Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:11 lounge volumio[3317]: info: Getting Spotify Cloud Configuration Jan 12 16:39:11 lounge volumio[3317]: info: Asking plugin for UI Config Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:11 lounge volumio[3317]: info: Saving Spotify Acccount Jan 12 16:39:11 lounge volumio[3317]: info: Got it Jan 12 16:39:11 lounge volumio[3317]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 12 16:39:11 lounge volumio[3317]: info: Got Tidal Cloud Configuration Jan 12 16:39:11 lounge volumio[3317]: info: Got it Jan 12 16:39:11 lounge volumio[3317]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 12 16:39:12 lounge volumio[3317]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 12 16:39:12 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 12 16:39:12 lounge volumio[3317]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 9 Jan 12 16:39:12 lounge volumio[3317]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jan 12 16:39:12 lounge volumio[3317]: info: Loading i18n strings for locale en Jan 12 16:39:12 lounge volumio[3317]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:39:12 lounge volumio[3317]: TypeError: Cannot read property 'logger' of null Jan 12 16:39:12 lounge volumio[3317]: at NowPlayingContext.getLogger (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:71:83) Jan 12 16:39:12 lounge volumio[3317]: at ControllerNowPlaying._ControllerNowPlaying_onVolumioLanguageChanged (/data/plugins/user_interface/now_playing/dist/index.js:2032:33) Jan 12 16:39:12 lounge volumio[3317]: at /volumio/node_modules/v-conf/index.js:165:13 Jan 12 16:39:12 lounge volumio[3317]: at /volumio/node_modules/multimap/index.js:150:9 Jan 12 16:39:12 lounge volumio[3317]: at Array.forEach () Jan 12 16:39:12 lounge volumio[3317]: at /volumio/node_modules/multimap/index.js:149:13 Jan 12 16:39:12 lounge volumio[3317]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Jan 12 16:39:12 lounge volumio[3317]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Jan 12 16:39:12 lounge volumio[3317]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Jan 12 16:39:12 lounge volumio[3317]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Jan 12 16:39:12 lounge volumio[3317]: at volumioAppearance.setLanguage (/volumio/app/plugins/miscellanea/appearance/index.js:326:35) Jan 12 16:39:12 lounge volumio[3317]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Jan 12 16:39:12 lounge volumio[3317]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1685:37) Jan 12 16:39:12 lounge volumio[3317]: at Socket.emit (events.js:400:28) Jan 12 16:39:12 lounge volumio[3317]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 12 16:39:12 lounge volumio[3317]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jan 12 16:39:12 lounge volumio[3317]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:39:13 lounge sudo[12446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 16:38 Jan 12 16:39:13 lounge sudo[12446]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"