Feb 12 09:57:00 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:00 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:00 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:00 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: new full-speed USB device number 34 using dwc_otg Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: New USB device found, idVendor=17ae, idProduct=0003, bcdDevice= 1.00 Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: Product: NAD USB Audio Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: Manufacturer: NAD Electronics Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: SerialNumber: (C) 2011 Wavelength Audio, ltd. Feb 12 09:57:05 volumio-kontoret kernel: usb 1-1.3: 1:1: cannot get freq at ep 0x1 Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Feb 12 09:57:05 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Attached Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::Close All Modals sent Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Preparing to save Alsa Options, stopping services first Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioStop Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreStateMachine::stop Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"NAD USB Audio","alsacard":"Audio"},"i2s":false} Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Setting default mixerSoftMaster for Softvolume device Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:05 volumio-kontoret vtcs[1855]: [2026-02-12 09:57:05.763] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Feb 12 09:57:05 volumio-kontoret vtcs[1855]: [2026-02-12 09:57:05.763] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 12 09:57:05 volumio-kontoret sudo[1974]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:05 volumio-kontoret sudo[1974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Disabling external Volume Control Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 09:57:05 volumio-kontoret systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 12 09:57:05 volumio-kontoret systemd[1]: vtcs.service: Killing process 1872 (vtcs) with signal SIGKILL. Feb 12 09:57:05 volumio-kontoret volumio[28512]: info: Enable softmixer device for audio device undefined Feb 12 09:57:05 volumio-kontoret systemd[1]: vtcs.service: Deactivated successfully. Feb 12 09:57:05 volumio-kontoret systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 12 09:57:05 volumio-kontoret sudo[1974]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:06 volumio-kontoret sudo[1988]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:06 volumio-kontoret sudo[1988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:06 volumio-kontoret sudo[1995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:57:06 volumio-kontoret sudo[1995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Software Volume ALSA configuration written Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Preparing to generate the ALSA configuration file Feb 12 09:57:06 volumio-kontoret sudo[1988]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:06 volumio-kontoret sudo[1995]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:06 volumio-kontoret sudo[2001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:57:06 volumio-kontoret sudo[2001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Reading ALSA contributions from plugins. Feb 12 09:57:06 volumio-kontoret systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 12 09:57:06 volumio-kontoret qobuz-connect[1837]: 20260212 09:57:06.384 [1837.1837] INFO SampleApp: Stopping Local configuration server Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Asound.conf file unchanged, so no further update is needed Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Output device has changed, restarting MPD Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Output device has changed, restarting Shairport Sync Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:06 volumio-kontoret sudo[2007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 09:57:06 volumio-kontoret sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret sudo[2009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 09:57:06 volumio-kontoret sudo[2007]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:06 volumio-kontoret sudo[2009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:06 volumio-kontoret systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 12 09:57:06 volumio-kontoret sudo[2019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:06 volumio-kontoret sudo[2019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret sudo[2022]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:06 volumio-kontoret sudo[2022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: MPD Permissions set Feb 12 09:57:06 volumio-kontoret sudo[2029]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:57:06 volumio-kontoret systemd[1]: mpd.service: Deactivated successfully. Feb 12 09:57:06 volumio-kontoret systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 12 09:57:06 volumio-kontoret systemd[1]: mpd.service: Consumed 5.864s CPU time. Feb 12 09:57:06 volumio-kontoret sudo[2029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret systemd[1]: mpd.socket: Deactivated successfully. Feb 12 09:57:06 volumio-kontoret systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 12 09:57:06 volumio-kontoret systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:06 volumio-kontoret volumio[28512]: info: Starting Shairport Sync Feb 12 09:57:06 volumio-kontoret systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 12 09:57:06 volumio-kontoret sudo[2038]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 09:57:06 volumio-kontoret sudo[2038]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:06 volumio-kontoret systemd[1]: Starting mpd.service - Music Player Daemon... Feb 12 09:57:07 volumio-kontoret sudo[2029]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 09:57:07 volumio-kontoret systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 09:57:07 volumio-kontoret systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:57:07 volumio-kontoret systemd[1]: shairport-sync.service: Consumed 2.029s CPU time. Feb 12 09:57:07 volumio-kontoret sudo[2041]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:57:07 volumio-kontoret sudo[2041]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:07 volumio-kontoret sudo[2022]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret sudo[2019]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:07 volumio-kontoret qobuz-connect[1837]: 20260212 09:57:07.237 [1837.1837] INFO SampleApp: shat down connection on UNIX socket Feb 12 09:57:07 volumio-kontoret systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 12 09:57:07 volumio-kontoret systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:57:07 volumio-kontoret sudo[2039]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 09:57:07 volumio-kontoret sudo[2039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 09:57:07 volumio-kontoret systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:57:07 volumio-kontoret sudo[2039]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret sudo[2001]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:57:07 volumio-kontoret sudo[2038]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: Shairport-Sync Started Feb 12 09:57:07 volumio-kontoret sudo[2041]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: Executing endpoint qc_getconfig Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.554 [2045.2045] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.574 [2045.2045] INFO VolumeManager: [0x1a03178]: Setting new playback volume: 75 Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.574 [2045.2045] INFO VolumeManager: [0x1a03178]: Setting new mute state: 0 Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.574 [2045.2045] INFO QobuzConnect: [0x1a03b48]: Client initialized! Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.574 [2045.2045] INFO SampleApp: Starting Avahi advertising, name: Volumio Kontoret, service name: _qobuz-connect._tcp Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.637 [2045.2045] INFO LocalConfigManager: [0x1a02a58]: Starting Local Configuration server Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.638 [2045.2045] INFO SampleApp: Starting Local configuration server Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.639 [2045.2045] INFO SampleApp: Connected to UNIX socket client 0x19ed818 Feb 12 09:57:07 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:07.708 [2045.2045] INFO SampleApp: Playback volume changed: 75 Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:07 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: [1770886628746] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:08 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:08 volumio-kontoret volumio[28512]: info: [1770886628761] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:08 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:09 volumio-kontoret sudo[2078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:57:09 volumio-kontoret sudo[2078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: [1770886629408] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:09 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:09 volumio-kontoret systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 12 09:57:09 volumio-kontoret sudo[2078]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreStateMachine::getcurrentVolume Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:09 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreStateMachine::updateTrackBlock Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrackBlock Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Executing endpoint tc_getconfig Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 09:57:10 volumio-kontoret vtcs[2081]: STARTING TidalConnect services, version: 1.5.2.56 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret vtcs[2081]: STARTED TidalConnect services. Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Executing endpoint tc_connect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Connecting to TidalConnect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:10 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:10 volumio-kontoret sudo[2118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:57:10 volumio-kontoret sudo[2118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:10 volumio-kontoret sudo[2118]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:12 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:12 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:12 volumio-kontoret mpd[2048]: 2026-02-12T09:57:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 09:57:12 volumio-kontoret systemd[1]: Started mpd.service - Music Player Daemon. Feb 12 09:57:12 volumio-kontoret sudo[2009]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:12 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:57:12 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:57:13 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:57:20 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:20+01:00" level=trace msg="sent dealer ping" Feb 12 09:57:21 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:21+01:00" level=trace msg="received dealer pong" Feb 12 09:57:27 volumio-kontoret kernel: usb 1-1.3: USB disconnect, device number 34 Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: Feb 12 09:57:27 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Detached Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: [1770886647906] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:27 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: sendMpdCommand stop took 6 milliseconds Feb 12 09:57:27 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clear Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: Feb 12 09:57:27 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: sendMpdCommand clear took 5 milliseconds Feb 12 09:57:27 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand load "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:57:27 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:57:27 volumio-kontoret volumio[28512]: info: ------------------------------ 6ms Feb 12 09:57:30 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: Feb 12 09:57:30 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" took 3 milliseconds Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 12 09:57:30 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand play Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: ------------------------------ 5ms Feb 12 09:57:30 volumio-kontoret volumio[28512]: info: sendMpdCommand play took 4 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: Feb 12 09:57:32 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: Feb 12 09:57:32 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 37 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: sendMpdCommand clearerror took 7 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 7 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ------------------------------ 77ms Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:57:32 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:32 volumio-kontoret volumio[28512]: info: ------------------------------ 68ms Feb 12 09:57:34 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:34 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:34 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:34 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: new full-speed USB device number 35 using dwc_otg Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: New USB device found, idVendor=17ae, idProduct=0003, bcdDevice= 1.00 Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: Product: NAD USB Audio Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: Manufacturer: NAD Electronics Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: SerialNumber: (C) 2011 Wavelength Audio, ltd. Feb 12 09:57:39 volumio-kontoret kernel: usb 1-1.3: 1:1: cannot get freq at ep 0x1 Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Feb 12 09:57:39 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Attached Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::Close All Modals sent Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Preparing to save Alsa Options, stopping services first Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioStop Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreStateMachine::stop Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"NAD USB Audio","alsacard":"Audio"},"i2s":false} Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Setting default mixerSoftMaster for Softvolume device Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:39 volumio-kontoret vtcs[2081]: [2026-02-12 09:57:39.837] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Feb 12 09:57:39 volumio-kontoret vtcs[2081]: [2026-02-12 09:57:39.838] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 12 09:57:39 volumio-kontoret sudo[2203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:39 volumio-kontoret sudo[2203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Disabling external Volume Control Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 09:57:39 volumio-kontoret volumio[28512]: info: Enable softmixer device for audio device undefined Feb 12 09:57:39 volumio-kontoret systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 12 09:57:39 volumio-kontoret systemd[1]: vtcs.service: Killing process 2100 (vtcs) with signal SIGKILL. Feb 12 09:57:40 volumio-kontoret systemd[1]: vtcs.service: Deactivated successfully. Feb 12 09:57:40 volumio-kontoret systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 12 09:57:40 volumio-kontoret sudo[2203]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:40 volumio-kontoret sudo[2218]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:40 volumio-kontoret sudo[2218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:40 volumio-kontoret sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:57:40 volumio-kontoret sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret volumio[28512]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Software Volume ALSA configuration written Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Preparing to generate the ALSA configuration file Feb 12 09:57:40 volumio-kontoret sudo[2224]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:40 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:40+01:00" level=trace msg="received accesspoint ping" Feb 12 09:57:40 volumio-kontoret sudo[2218]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:40 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:40+01:00" level=trace msg="received accesspoint pong ack" Feb 12 09:57:40 volumio-kontoret sudo[2226]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:57:40 volumio-kontoret sudo[2226]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 12 09:57:40 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:40.396 [2045.2045] INFO SampleApp: Stopping Local configuration server Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Reading ALSA contributions from plugins. Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Asound.conf file unchanged, so no further update is needed Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Output device has changed, restarting MPD Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Output device has changed, restarting Shairport Sync Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:40 volumio-kontoret sudo[2236]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 09:57:40 volumio-kontoret sudo[2236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret sudo[2238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 09:57:40 volumio-kontoret sudo[2236]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:40 volumio-kontoret sudo[2238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:40 volumio-kontoret systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 12 09:57:40 volumio-kontoret sudo[2248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:40 volumio-kontoret sudo[2248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret sudo[2250]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:57:40 volumio-kontoret sudo[2250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: MPD Permissions set Feb 12 09:57:40 volumio-kontoret systemd[1]: mpd.service: Deactivated successfully. Feb 12 09:57:40 volumio-kontoret systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret systemd[1]: mpd.service: Consumed 5.840s CPU time. Feb 12 09:57:40 volumio-kontoret sudo[2258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:57:40 volumio-kontoret sudo[2258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:40 volumio-kontoret systemd[1]: mpd.socket: Deactivated successfully. Feb 12 09:57:40 volumio-kontoret volumio[28512]: info: Starting Shairport Sync Feb 12 09:57:40 volumio-kontoret systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 12 09:57:40 volumio-kontoret systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 12 09:57:40 volumio-kontoret sudo[2267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 09:57:40 volumio-kontoret sudo[2267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:41 volumio-kontoret systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 12 09:57:41 volumio-kontoret systemd[1]: Starting mpd.service - Music Player Daemon... Feb 12 09:57:41 volumio-kontoret sudo[2258]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret sudo[2248]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret sudo[2250]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret sudo[2270]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:57:41 volumio-kontoret sudo[2270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:41 volumio-kontoret systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 09:57:41 volumio-kontoret systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 09:57:41 volumio-kontoret systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:57:41 volumio-kontoret systemd[1]: shairport-sync.service: Consumed 2.003s CPU time. Feb 12 09:57:41 volumio-kontoret systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:57:41 volumio-kontoret sudo[2269]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 09:57:41 volumio-kontoret sudo[2269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 09:57:41 volumio-kontoret sudo[2267]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret sudo[2269]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: Shairport-Sync Started Feb 12 09:57:41 volumio-kontoret qobuz-connect[2045]: 20260212 09:57:41.673 [2045.2045] INFO SampleApp: shat down connection on UNIX socket Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:41 volumio-kontoret systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 12 09:57:41 volumio-kontoret systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:57:41 volumio-kontoret systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:57:41 volumio-kontoret sudo[2270]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret sudo[2226]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: Executing endpoint qc_getconfig Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 09:57:41 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:41.983 [2291.2291] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 09:57:41 volumio-kontoret volumio[28512]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.001 [2291.2291] INFO VolumeManager: [0x1300178]: Setting new playback volume: 75 Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.001 [2291.2291] INFO VolumeManager: [0x1300178]: Setting new mute state: 0 Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.002 [2291.2291] INFO QobuzConnect: [0x1300b48]: Client initialized! Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.002 [2291.2291] INFO SampleApp: Starting Avahi advertising, name: Volumio Kontoret, service name: _qobuz-connect._tcp Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.052 [2291.2291] INFO LocalConfigManager: [0x12ffa58]: Starting Local Configuration server Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.052 [2291.2291] INFO SampleApp: Starting Local configuration server Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.054 [2291.2291] INFO SampleApp: Connected to UNIX socket client 0x12ea818 Feb 12 09:57:42 volumio-kontoret qobuz-connect[2291]: 20260212 09:57:42.133 [2291.2291] INFO SampleApp: Playback volume changed: 75 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: [1770886662932] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:42 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:42 volumio-kontoret volumio[28512]: info: [1770886662940] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:42 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: [1770886663350] ControllerWebradio::clearAddPlayTrack Feb 12 09:57:43 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:43 volumio-kontoret sudo[2321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:57:43 volumio-kontoret sudo[2321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:43 volumio-kontoret systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 12 09:57:43 volumio-kontoret sudo[2321]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreStateMachine::getcurrentVolume Feb 12 09:57:43 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreStateMachine::updateTrackBlock Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrackBlock Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Executing endpoint tc_getconfig Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:44 volumio-kontoret vtcs[2324]: STARTING TidalConnect services, version: 1.5.2.56 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret vtcs[2324]: STARTED TidalConnect services. Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Executing endpoint tc_connect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Connecting to TidalConnect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:44 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:57:44 volumio-kontoret sudo[2361]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:57:44 volumio-kontoret sudo[2361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:57:44 volumio-kontoret sudo[2361]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:46 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:57:46 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:57:46 volumio-kontoret mpd[2276]: 2026-02-12T09:57:46 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 09:57:46 volumio-kontoret systemd[1]: Started mpd.service - Music Player Daemon. Feb 12 09:57:46 volumio-kontoret sudo[2238]: pam_unix(sudo:session): session closed for user root Feb 12 09:57:46 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:57:46 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:57:47 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:57:47 volumio-kontoret nmbd[907]: [2026/02/12 09:57:47.754237, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 12 09:57:47 volumio-kontoret nmbd[907]: register_name_response: Answer name <00> differs from question name <00>. Feb 12 09:57:47 volumio-kontoret nmbd[907]: [2026/02/12 09:57:47.755296, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 12 09:57:47 volumio-kontoret nmbd[907]: register_name_response: Answer name <03> differs from question name <03>. Feb 12 09:57:47 volumio-kontoret nmbd[907]: [2026/02/12 09:57:47.756027, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 12 09:57:47 volumio-kontoret nmbd[907]: register_name_response: Answer name <20> differs from question name <20>. Feb 12 09:57:50 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:50+01:00" level=trace msg="sent dealer ping" Feb 12 09:57:51 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:57:51+01:00" level=trace msg="received dealer pong" Feb 12 09:58:01 volumio-kontoret kernel: usb 1-1.3: USB disconnect, device number 35 Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: Feb 12 09:58:01 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Detached Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: [1770886681868] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:01 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: sendMpdCommand stop took 2 milliseconds Feb 12 09:58:01 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clear Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: Feb 12 09:58:01 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: sendMpdCommand clear took 2 milliseconds Feb 12 09:58:01 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand load "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:58:01 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:58:01 volumio-kontoret volumio[28512]: info: ------------------------------ 3ms Feb 12 09:58:04 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: Feb 12 09:58:04 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" took 3 milliseconds Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 12 09:58:04 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand play Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: ------------------------------ 4ms Feb 12 09:58:04 volumio-kontoret volumio[28512]: info: sendMpdCommand play took 4 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: Feb 12 09:58:06 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: Feb 12 09:58:06 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 38 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: sendMpdCommand clearerror took 5 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 4 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ------------------------------ 86ms Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 65 milliseconds Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:58:06 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:06 volumio-kontoret volumio[28512]: info: ------------------------------ 115ms Feb 12 09:58:08 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:08 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:08 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:12 volumio-kontoret kernel: usb 1-1.3: new full-speed USB device number 36 using dwc_otg Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: New USB device found, idVendor=17ae, idProduct=0003, bcdDevice= 1.00 Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: Product: NAD USB Audio Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: Manufacturer: NAD Electronics Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: SerialNumber: (C) 2011 Wavelength Audio, ltd. Feb 12 09:58:13 volumio-kontoret kernel: usb 1-1.3: 1:1: cannot get freq at ep 0x1 Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Feb 12 09:58:13 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Attached Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::Close All Modals sent Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Preparing to save Alsa Options, stopping services first Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioStop Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreStateMachine::stop Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"NAD USB Audio","alsacard":"Audio"},"i2s":false} Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Setting default mixerSoftMaster for Softvolume device Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:13 volumio-kontoret vtcs[2324]: [2026-02-12 09:58:13.604] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 12 09:58:13 volumio-kontoret vtcs[2324]: [2026-02-12 09:58:13.608] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Feb 12 09:58:13 volumio-kontoret vtcs[2324]: [2026-02-12 09:58:13.609] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Feb 12 09:58:13 volumio-kontoret sudo[2443]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:13 volumio-kontoret sudo[2443]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Disabling external Volume Control Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 09:58:13 volumio-kontoret systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 12 09:58:13 volumio-kontoret systemd[1]: vtcs.service: Killing process 2342 (vtcs) with signal SIGKILL. Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: Enable softmixer device for audio device undefined Feb 12 09:58:13 volumio-kontoret systemd[1]: vtcs.service: Deactivated successfully. Feb 12 09:58:13 volumio-kontoret systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 12 09:58:13 volumio-kontoret sudo[2443]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:13 volumio-kontoret sudo[2457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:13 volumio-kontoret sudo[2457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:13 volumio-kontoret sudo[2465]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:13 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:13 volumio-kontoret sudo[2465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:14 volumio-kontoret sudo[2457]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:14 volumio-kontoret volumio[28512]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Feb 12 09:58:14 volumio-kontoret sudo[2465]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:14 volumio-kontoret sudo[2468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:58:14 volumio-kontoret sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Software Volume ALSA configuration written Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Preparing to generate the ALSA configuration file Feb 12 09:58:14 volumio-kontoret systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 12 09:58:14 volumio-kontoret qobuz-connect[2291]: 20260212 09:58:14.242 [2291.2291] INFO SampleApp: Stopping Local configuration server Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Reading ALSA contributions from plugins. Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Asound.conf file unchanged, so no further update is needed Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Output device has changed, restarting MPD Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Output device has changed, restarting Shairport Sync Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:14 volumio-kontoret sudo[2477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 09:58:14 volumio-kontoret sudo[2477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret sudo[2477]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:14 volumio-kontoret sudo[2479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 09:58:14 volumio-kontoret sudo[2479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:14 volumio-kontoret systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 12 09:58:14 volumio-kontoret sudo[2489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:14 volumio-kontoret sudo[2489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret sudo[2491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:14 volumio-kontoret sudo[2491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:14 volumio-kontoret systemd[1]: mpd.service: Deactivated successfully. Feb 12 09:58:14 volumio-kontoret systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 12 09:58:14 volumio-kontoret systemd[1]: mpd.service: Consumed 5.971s CPU time. Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: MPD Permissions set Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret sudo[2499]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:58:14 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:14 volumio-kontoret sudo[2499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:15 volumio-kontoret systemd[1]: mpd.socket: Deactivated successfully. Feb 12 09:58:15 volumio-kontoret systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 12 09:58:15 volumio-kontoret systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 12 09:58:15 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:15 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:15 volumio-kontoret volumio[28512]: info: Starting Shairport Sync Feb 12 09:58:15 volumio-kontoret systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 12 09:58:15 volumio-kontoret systemd[1]: Starting mpd.service - Music Player Daemon... Feb 12 09:58:15 volumio-kontoret sudo[2509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 09:58:15 volumio-kontoret sudo[2509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:15 volumio-kontoret sudo[2499]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:15 volumio-kontoret systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 09:58:15 volumio-kontoret sudo[2512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:58:15 volumio-kontoret sudo[2512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:15 volumio-kontoret systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 09:58:15 volumio-kontoret systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:58:15 volumio-kontoret systemd[1]: shairport-sync.service: Consumed 1.982s CPU time. Feb 12 09:58:15 volumio-kontoret sudo[2489]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:15 volumio-kontoret sudo[2491]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:15 volumio-kontoret sudo[2510]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 09:58:15 volumio-kontoret sudo[2510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 09:58:15 volumio-kontoret sudo[2510]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:15 volumio-kontoret systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:58:15 volumio-kontoret sudo[2509]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:15 volumio-kontoret volumio[28512]: info: Shairport-Sync Started Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:16 volumio-kontoret qobuz-connect[2291]: 20260212 09:58:16.102 [2291.2291] INFO SampleApp: shat down connection on UNIX socket Feb 12 09:58:16 volumio-kontoret systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 12 09:58:16 volumio-kontoret systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:16 volumio-kontoret sudo[2468]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:16 volumio-kontoret sudo[2512]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: Executing endpoint qc_getconfig Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.402 [2533.2533] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.426 [2533.2533] INFO VolumeManager: [0x1600178]: Setting new playback volume: 75 Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.428 [2533.2533] INFO VolumeManager: [0x1600178]: Setting new mute state: 0 Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.428 [2533.2533] INFO QobuzConnect: [0x1600b48]: Client initialized! Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.429 [2533.2533] INFO SampleApp: Starting Avahi advertising, name: Volumio Kontoret, service name: _qobuz-connect._tcp Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.476 [2533.2533] INFO LocalConfigManager: [0x15ffa58]: Starting Local Configuration server Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.476 [2533.2533] INFO SampleApp: Starting Local configuration server Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.477 [2533.2533] INFO SampleApp: Connected to UNIX socket client 0x15ea818 Feb 12 09:58:16 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:16.552 [2533.2533] INFO SampleApp: Playback volume changed: 75 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: [1770886696629] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:16 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: [1770886696665] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:16 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:16 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:17 volumio-kontoret sudo[2548]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:58:17 volumio-kontoret sudo[2548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: [1770886697315] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:17 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:17 volumio-kontoret systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 12 09:58:17 volumio-kontoret sudo[2548]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::getcurrentVolume Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::updateTrackBlock Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrackBlock Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:17 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Executing endpoint tc_getconfig Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 09:58:18 volumio-kontoret vtcs[2551]: STARTING TidalConnect services, version: 1.5.2.56 Feb 12 09:58:18 volumio-kontoret vtcs[2551]: STARTED TidalConnect services. Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Executing endpoint tc_connect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Connecting to TidalConnect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:18 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:18 volumio-kontoret sudo[2588]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:58:18 volumio-kontoret sudo[2588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:18 volumio-kontoret sudo[2588]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:20 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:20 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:20 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:58:20 volumio-kontoret mpd[2518]: 2026-02-12T09:58:20 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 12 09:58:20 volumio-kontoret systemd[1]: Started mpd.service - Music Player Daemon. Feb 12 09:58:20 volumio-kontoret sudo[2479]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:20 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:58:20 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:58:20+01:00" level=trace msg="sent dealer ping" Feb 12 09:58:21 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:58:21+01:00" level=trace msg="received dealer pong" Feb 12 09:58:21 volumio-kontoret volumio[28512]: info: TidalConnect service started! Feb 12 09:58:34 volumio-kontoret kernel: usb 1-1.3: USB disconnect, device number 36 Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: Feb 12 09:58:35 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Detached Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: [1770886715852] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:35 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: sendMpdCommand stop took 1 milliseconds Feb 12 09:58:35 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clear Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: Feb 12 09:58:35 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: sendMpdCommand clear took 2 milliseconds Feb 12 09:58:35 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand load "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:58:35 volumio-kontoret volumio[28512]: error: updateQueue error: null Feb 12 09:58:35 volumio-kontoret volumio[28512]: info: ------------------------------ 3ms Feb 12 09:58:38 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: sendMpdCommand add "http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/" took 1 milliseconds Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 12 09:58:38 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand play Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: Feb 12 09:58:38 volumio-kontoret volumio[28512]: ---------------------------- MPD announces system playlist update Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: Ignoring MPD Status Update Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: sendMpdCommand play took 4 milliseconds Feb 12 09:58:38 volumio-kontoret volumio[28512]: info: ------------------------------ 4ms Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: Feb 12 09:58:40 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: Feb 12 09:58:40 volumio-kontoret volumio[28512]: ---------------------------- MPD announces state update: player Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ControllerMpd::getState Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand status Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 18 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand status took 26 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand clearerror took 10 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseState Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ------------------------------ 69ms Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand clearerror took 63 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: sendMpdCommand playlistinfo took 60 milliseconds Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: ControllerMpd::parseTrackInfo Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ControllerMpd::pushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://streams.fluxfm.de/jazzschwarz/mp3-320/tunein/","trackType":""} Feb 12 09:58:40 volumio-kontoret volumio[28512]: verbose: CURRENT POSITION 0 Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState stateService pause Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::syncState currentStatus stop Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:40 volumio-kontoret volumio[28512]: info: ------------------------------ 109ms Feb 12 09:58:42 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:42 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:42 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:46 volumio-kontoret kernel: usb 1-1.3: new full-speed USB device number 37 using dwc_otg Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: New USB device found, idVendor=17ae, idProduct=0003, bcdDevice= 1.00 Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: Product: NAD USB Audio Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: Manufacturer: NAD Electronics Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: SerialNumber: (C) 2011 Wavelength Audio, ltd. Feb 12 09:58:47 volumio-kontoret kernel: usb 1-1.3: 1:1: cannot get freq at ep 0x1 Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Feb 12 09:58:47 volumio-kontoret volumio[28512]: ---------------------------- USB Audio Device Attached Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::Close All Modals sent Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Preparing to save Alsa Options, stopping services first Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioStop Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreStateMachine::stop Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"NAD USB Audio","alsacard":"Audio"},"i2s":false} Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Setting default mixerSoftMaster for Softvolume device Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:47 volumio-kontoret vtcs[2551]: [2026-02-12 09:58:47.517] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Feb 12 09:58:47 volumio-kontoret vtcs[2551]: [2026-02-12 09:58:47.518] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 12 09:58:47 volumio-kontoret sudo[2669]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:47 volumio-kontoret sudo[2669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Disabling external Volume Control Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Enable softmixer device for audio device undefined Feb 12 09:58:47 volumio-kontoret systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 12 09:58:47 volumio-kontoret systemd[1]: vtcs.service: Killing process 2570 (vtcs) with signal SIGKILL. Feb 12 09:58:47 volumio-kontoret systemd[1]: vtcs.service: Deactivated successfully. Feb 12 09:58:47 volumio-kontoret systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 12 09:58:47 volumio-kontoret sudo[2669]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:47 volumio-kontoret sudo[2683]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:47 volumio-kontoret sudo[2683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:47 volumio-kontoret volumio[28512]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Feb 12 09:58:47 volumio-kontoret sudo[2690]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:58:47 volumio-kontoret sudo[2690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Software Volume ALSA configuration written Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Preparing to generate the ALSA configuration file Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 12 09:58:47 volumio-kontoret sudo[2683]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:47 volumio-kontoret volumio[28512]: info: Reading ALSA contributions from plugins. Feb 12 09:58:47 volumio-kontoret sudo[2690]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 12 09:58:48 volumio-kontoret sudo[2695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:58:48 volumio-kontoret sudo[2695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 12 09:58:48 volumio-kontoret systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 12 09:58:48 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:48.125 [2533.2533] INFO SampleApp: Stopping Local configuration server Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Asound.conf file unchanged, so no further update is needed Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Output device has changed, restarting MPD Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Output device has changed, restarting Shairport Sync Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:48 volumio-kontoret sudo[2702]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 12 09:58:48 volumio-kontoret sudo[2702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret sudo[2702]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:48 volumio-kontoret sudo[2704]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 12 09:58:48 volumio-kontoret sudo[2704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:48 volumio-kontoret systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 12 09:58:48 volumio-kontoret sudo[2714]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:48 volumio-kontoret sudo[2714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret sudo[2716]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 12 09:58:48 volumio-kontoret sudo[2716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: MPD Permissions set Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret systemd[1]: mpd.service: Deactivated successfully. Feb 12 09:58:48 volumio-kontoret systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 12 09:58:48 volumio-kontoret systemd[1]: mpd.service: Consumed 5.858s CPU time. Feb 12 09:58:48 volumio-kontoret sudo[2724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 12 09:58:48 volumio-kontoret sudo[2724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret qobuz-connect[2533]: 20260212 09:58:48.528 [2533.2533] INFO SampleApp: shat down connection on UNIX socket Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Starting Shairport Sync Feb 12 09:58:48 volumio-kontoret systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 12 09:58:48 volumio-kontoret systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:48 volumio-kontoret sudo[2732]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 12 09:58:48 volumio-kontoret systemd[1]: mpd.socket: Deactivated successfully. Feb 12 09:58:48 volumio-kontoret sudo[2732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret sudo[2724]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:48 volumio-kontoret systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 12 09:58:48 volumio-kontoret systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 12 09:58:48 volumio-kontoret sudo[2734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 12 09:58:48 volumio-kontoret sudo[2734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:48 volumio-kontoret systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 12 09:58:48 volumio-kontoret systemd[1]: Starting mpd.service - Music Player Daemon... Feb 12 09:58:48 volumio-kontoret systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:48 volumio-kontoret sudo[2695]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: Executing endpoint qc_getconfig Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 09:58:48 volumio-kontoret sudo[2716]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:48 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:48.953 [2739.2739] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 09:58:48 volumio-kontoret volumio[28512]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 09:58:48 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:48.964 [2739.2739] INFO VolumeManager: [0x5c3178]: Setting new playback volume: 75 Feb 12 09:58:48 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:48.964 [2739.2739] INFO VolumeManager: [0x5c3178]: Setting new mute state: 0 Feb 12 09:58:48 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:48.964 [2739.2739] INFO QobuzConnect: [0x5c3b48]: Client initialized! Feb 12 09:58:48 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:48.964 [2739.2739] INFO SampleApp: Starting Avahi advertising, name: Volumio Kontoret, service name: _qobuz-connect._tcp Feb 12 09:58:48 volumio-kontoret sudo[2714]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:49 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:49.019 [2739.2739] INFO LocalConfigManager: [0x5c2a58]: Starting Local Configuration server Feb 12 09:58:49 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:49.020 [2739.2739] INFO SampleApp: Starting Local configuration server Feb 12 09:58:49 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:49.021 [2739.2739] INFO SampleApp: Connected to UNIX socket client 0x5ad818 Feb 12 09:58:49 volumio-kontoret systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 12 09:58:49 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:49.053 [2739.2739] INFO SampleApp: Stopping Local configuration server Feb 12 09:58:49 volumio-kontoret systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 12 09:58:49 volumio-kontoret systemd[1]: shairport-sync.service: Deactivated successfully. Feb 12 09:58:49 volumio-kontoret systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:58:49 volumio-kontoret systemd[1]: shairport-sync.service: Consumed 2.008s CPU time. Feb 12 09:58:49 volumio-kontoret systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 12 09:58:49 volumio-kontoret sudo[2732]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:49 volumio-kontoret volumio[28512]: info: Shairport-Sync Started Feb 12 09:58:49 volumio-kontoret sudo[2738]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 12 09:58:49 volumio-kontoret sudo[2738]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 12 09:58:49 volumio-kontoret sudo[2738]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:49 volumio-kontoret volumio[28512]: info: Executing endpoint metavolumio Feb 12 09:58:49 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: [1770886730629] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:50 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: [1770886730648] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:50 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:50 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:58:50+01:00" level=trace msg="sent dealer ping" Feb 12 09:58:50 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:51 volumio-kontoret qobuz-connect[2739]: 20260212 09:58:51.029 [2739.2739] INFO SampleApp: shat down connection on UNIX socket Feb 12 09:58:51 volumio-kontoret systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 12 09:58:51 volumio-kontoret systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: QobuzConnect: setDeactiveState invoked Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:51 volumio-kontoret go-librespot[28757]: time="2026-02-12T09:58:51+01:00" level=trace msg="received dealer pong" Feb 12 09:58:51 volumio-kontoret systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 12 09:58:51 volumio-kontoret sudo[2734]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:51 volumio-kontoret sudo[2774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 12 09:58:51 volumio-kontoret sudo[2774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Executing endpoint qc_getconfig Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.294 [2772.2772] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.306 [2772.2772] INFO VolumeManager: [0x951178]: Setting new playback volume: 75 Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.306 [2772.2772] INFO VolumeManager: [0x951178]: Setting new mute state: 0 Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.306 [2772.2772] INFO QobuzConnect: [0x951b48]: Client initialized! Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.306 [2772.2772] INFO SampleApp: Starting Avahi advertising, name: Volumio Kontoret, service name: _qobuz-connect._tcp Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPlay Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::play index undefined Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::startPlaybackTimer Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetVisibleSources Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: [1770886731320] ControllerWebradio::clearAddPlayTrack Feb 12 09:58:51 volumio-kontoret volumio[28512]: verbose: ControllerMpd::sendMpdCommand stop Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 12 09:58:51 volumio-kontoret systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 12 09:58:51 volumio-kontoret sudo[2774]: pam_unix(sudo:session): session closed for user root Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.387 [2772.2772] INFO LocalConfigManager: [0x950a58]: Starting Local Configuration server Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.387 [2772.2772] INFO SampleApp: Starting Local configuration server Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.388 [2772.2772] INFO SampleApp: Connected to UNIX socket client 0x93b818 Feb 12 09:58:51 volumio-kontoret qobuz-connect[2772]: 20260212 09:58:51.443 [2772.2772] INFO SampleApp: Playback volume changed: 75 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::getcurrentVolume Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::updateTrackBlock Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrackBlock Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioRetrievevolume Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Executing endpoint tc_getconfig Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 12 09:58:51 volumio-kontoret vtcs[2780]: STARTING TidalConnect services, version: 1.5.2.56 Feb 12 09:58:51 volumio-kontoret vtcs[2780]: STARTED TidalConnect services. Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Executing endpoint tc_connect Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 12 09:58:51 volumio-kontoret volumio[28512]: info: Connecting to TidalConnect Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::servicePushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreStateMachine::pushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioPushState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output update for this device Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: MRS: Pushing multiroomSync output Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CoreCommandRouter::volumioGetState Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: CorePlayQueue::getTrack 0 Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: TidalConnect service stoped! Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:52 volumio-kontoret volumio[28512]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 12 09:58:52 volumio-kontoret volumio[28512]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 09:58:52 volumio-kontoret volumio[28512]: Error: ENOENT: no such file or directory, unlink '/tmp/3EN0dw8toQKRhOvvwwawusxBb6htWwvelZiNfsfOeEsiU4awq7ZCzU4SGua6UDdHsexPzet8JmD6i4A7agHf41L1flfdV3mntfJp' Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Object.unlinkSync (node:fs:1899:3) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at ControllerTidalconnect.deleteCertificate (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:11238) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at TidalConnectClient. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:2774) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at TidalConnectClient.emit (node:events:514:28) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at TidalConnectClient.parseData (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:44661) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at /myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41631 Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Array.forEach () Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Socket. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41509) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Socket.emit (node:events:514:28) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at addChunk (node:internal/streams/readable:343:12) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at readableAddChunk (node:internal/streams/readable:316:9) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Readable.push (node:internal/streams/readable:253:10) Feb 12 09:58:52 volumio-kontoret volumio[28512]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) { Feb 12 09:58:52 volumio-kontoret volumio[28512]: errno: -2, Feb 12 09:58:52 volumio-kontoret volumio[28512]: syscall: 'unlink', Feb 12 09:58:52 volumio-kontoret volumio[28512]: code: 'ENOENT', Feb 12 09:58:52 volumio-kontoret volumio[28512]: path: '/tmp/3EN0dw8toQKRhOvvwwawusxBb6htWwvelZiNfsfOeEsiU4awq7ZCzU4SGua6UDdHsexPzet8JmD6i4A7agHf41L1flfdV3mntfJp' Feb 12 09:58:52 volumio-kontoret volumio[28512]: } Feb 12 09:58:52 volumio-kontoret volumio[28512]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 12 09:58:53 volumio-kontoret sudo[2846]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-12 09:57' Feb 12 09:58:53 volumio-kontoret sudo[2846]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"