-- Logs begin at Thu 2019-02-14 06:11:58 AST, end at Mon 2026-01-26 18:48:33 AST. -- Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:00 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: Received Get System Info Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: Discovery: Getting this device information Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:01 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: Received Get System Info Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: Discovery: Getting this device information Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:02 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 18:47:03 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:03 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:03 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:03 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:03 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:04 klipsch-volumio volumiologrotate[602]: ls: cannot access '/var/log/samba/log.wb-KLIPSCH': No such file or directory Jan 26 18:47:04 klipsch-volumio volumiologrotate[602]: ls: cannot access 'VOLUMIO': No such file or directory Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: Getting Alsa Cards List without I2S DAC Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:04 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:04 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 18:47:04 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 18:47:05 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:05 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:05 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:05 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:05 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:06 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:06 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:06 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:06 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:06 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:07 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:07 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:07 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:07 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:07 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:08 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:08 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:08 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:08 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:08 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:09 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 26 18:47:10 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:10 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:10 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:10 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:10 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:11 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:11 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:11 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:11 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:11 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:12 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:12 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:12 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:12 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:12 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:13 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:13 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:13 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:13 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:13 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:14 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:14 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:14 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:14 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:14 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:15 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:15 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:15 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:15 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:15 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:16 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:16 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:16 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:16 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:16 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:17 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:17 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:17 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:17 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:17 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: Received Get System Version Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: Received Get System Info Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: Discovery: Getting this device information Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 18:47:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:19 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:20 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:20 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:20 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:20 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:20 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:21 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:21 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:21 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:21 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:21 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:23 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:23 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:23 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:23 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:23 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Preparing to save Alsa Options, stopping services first Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::pause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::stPlaybackTimer Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::servicePause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePause Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand pause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"I-Sabre Q2M DAC"},"i2s":true,"i2sid":{"value":"i-sabre-q2m","label":"Audiophonics I-Sabre ES9028Q2M"}} Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Found match in i2s Card Database: setting mixer Digital for card Audiophonics I-Sabre ES9028Q2M Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Disabling external Volume Control Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Enable softmixer device for audio device undefined Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Jan 26 18:47:24 klipsch-volumio volumio[1072]: ---------------------------- MPD announces state update: player Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: sendMpdCommand pause took 158 milliseconds Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: ControllerMpd::getState Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: STATE SERVICE {"status":"pause","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"/albumart?sourceicon=music_service/80s80s/images/80s80s-ndw-cover.png","name":"Dombrowski - Hör ma (Sabine Sabine Sabine)","title":"Hör ma (Sabine Sabine Sabine)","artist":"80s80s NDW","album":"","streaming":true,"disableUiControls":true,"duration":"196","seek":74816,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: CURRENT POSITION 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::syncState stateService pause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus pause Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: sendMpdCommand status took 20 milliseconds Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: ControllerMpd::parseState Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Software Volume ALSA configuration written Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Preparing to generate the ALSA configuration file Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: sendMpdCommand playlistinfo took 85 milliseconds Jan 26 18:47:24 klipsch-volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: ControllerMpd::pushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: ------------------------------ 111ms Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Reading ALSA contributions from plugins. Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Getting Alsa Cards List without I2S DAC Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:24 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Asound.conf file unchanged, so no further update is needed Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Output device has changed, restarting MPD Jan 26 18:47:24 klipsch-volumio sudo[2436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 18:47:24 klipsch-volumio sudo[2436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: Output device has changed, restarting Shairport Sync Jan 26 18:47:24 klipsch-volumio sudo[2436]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:25 klipsch-volumio sudo[2439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 18:47:25 klipsch-volumio sudo[2439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopping Music Player Daemon... Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio systemd[1]: mpd.service: Succeeded. Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopped Music Player Daemon. Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: QobuzConnect: setDeactiveState invoked Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:25 klipsch-volumio vtcs[1959]: [2026-01-26 18:47:25.067] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 26 18:47:25 klipsch-volumio vtcs[1959]: [2026-01-26 18:47:25.068] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 26 18:47:25 klipsch-volumio sudo[2448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 18:47:25 klipsch-volumio sudo[2448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio sudo[2451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 18:47:25 klipsch-volumio systemd[1]: Starting Music Player Daemon... Jan 26 18:47:25 klipsch-volumio sudo[2451]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jan 26 18:47:25 klipsch-volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jan 26 18:47:25 klipsch-volumio systemd[1]: vtcs.service: Succeeded. Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 26 18:47:25 klipsch-volumio sudo[2448]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio sudo[2451]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:47:25 klipsch-volumio sudo[2459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 26 18:47:25 klipsch-volumio sudo[2459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:25 klipsch-volumio sudo[2445]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 18:47:25 klipsch-volumio sudo[2445]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio sudo[2459]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio sudo[2445]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: MPD Permissions set Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio sudo[2462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 26 18:47:25 klipsch-volumio sudo[2462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: Starting Shairport Sync Jan 26 18:47:25 klipsch-volumio sudo[2470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 18:47:25 klipsch-volumio sudo[2470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 26 18:47:25 klipsch-volumio systemd[1]: shairport-sync.service: Succeeded. Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 26 18:47:25 klipsch-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 26 18:47:25 klipsch-volumio qobuz-connect[1908]: 20260126 18:47:25.331 [1908.1908] INFO SampleApp: Stopping Local configuration server Jan 26 18:47:25 klipsch-volumio sudo[2470]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio qobuz-connect[1908]: 20260126 18:47:25.343 [1908.1908] INFO SampleApp: shat down connection on UNIX socket Jan 26 18:47:25 klipsch-volumio systemd[1]: qobuz-connect.service: Succeeded. Jan 26 18:47:25 klipsch-volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 26 18:47:25 klipsch-volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 26 18:47:25 klipsch-volumio sudo[2462]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:47:25 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: Shairport-Sync Started Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: QobuzConnect: setDeactiveState invoked Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: Executing endpoint qc_getconfig Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.440 [2473.2473] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.445 [2473.2473] INFO VolumeManager: [0x18f8360]: Setting new playback volume: 75 Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.445 [2473.2473] INFO VolumeManager: [0x18f8360]: Setting new mute state: 0 Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.445 [2473.2473] INFO QobuzConnect: [0x18f8d30]: Client initialized! Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.445 [2473.2473] INFO SampleApp: Starting Avahi advertising, name: Klipsch Volumio, service name: _qobuz-connect._tcp Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.452 [2473.2473] INFO LocalConfigManager: [0x18f7c40]: Starting Local Configuration server Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.452 [2473.2473] INFO SampleApp: Starting Local configuration server Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.453 [2473.2473] INFO SampleApp: Connected to UNIX socket client 0x18edf60 Jan 26 18:47:25 klipsch-volumio qobuz-connect[2473]: 20260126 18:47:25.590 [2473.2473] INFO SampleApp: Playback volume changed: 75 Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:47:25 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:25 klipsch-volumio mpd[2464]: Jan 26 18:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 18:47:26 klipsch-volumio systemd[1]: Started Music Player Daemon. Jan 26 18:47:26 klipsch-volumio sudo[2439]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:26 klipsch-volumio volumio[1072]: error: updateQueue error: null Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: TidalConnect service stoped! Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: TidalConnect service stoped! Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 26 18:47:28 klipsch-volumio sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 26 18:47:28 klipsch-volumio sudo[2491]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:28 klipsch-volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 26 18:47:28 klipsch-volumio sudo[2491]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: Executing endpoint tc_getconfig Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 26 18:47:28 klipsch-volumio vtcs[2493]: STARTING TidalConnect services, version: 1.5.2.56 Jan 26 18:47:28 klipsch-volumio vtcs[2493]: STARTED TidalConnect services. Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: Executing endpoint tc_connect Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: Connecting to TidalConnect Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: error: Could not process JSON: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: error: Could not process JSON: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::getcurrentVolume Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::updateTrackBlock Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrackBlock Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:47:28 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:28 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:47:29 klipsch-volumio sudo[2531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 26 18:47:29 klipsch-volumio sudo[2531]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:47:29 klipsch-volumio systemd[1]: Stopping MPD Monitor Service... Jan 26 18:47:29 klipsch-volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 26 18:47:29 klipsch-volumio systemd[1]: mpd_monitor.service: Succeeded. Jan 26 18:47:29 klipsch-volumio systemd[1]: Stopped MPD Monitor Service. Jan 26 18:47:29 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:47:29 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:47:29 klipsch-volumio systemd[1]: Started MPD Monitor Service. Jan 26 18:47:29 klipsch-volumio sudo[2531]: pam_unix(sudo:session): session closed for user root Jan 26 18:47:29 klipsch-volumio mpd_monitor.sh[2533]: MPD Monitor Service: Starting MPD Monitor Service Jan 26 18:47:29 klipsch-volumio volumio[1072]: info: Successfully started MPD Monitor Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:47:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:47:30 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:47:31 klipsch-volumio volumio[1072]: info: TidalConnect service started! Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:47:32 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:47:32 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:47:32 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:04 klipsch-volumio volumiologrotate[602]: ls: cannot access '/var/log/samba/log.wb-KLIPSCH': No such file or directory Jan 26 18:48:04 klipsch-volumio volumiologrotate[602]: ls: cannot access 'VOLUMIO': No such file or directory Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Preparing to save Alsa Options, stopping services first Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPause Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreStateMachine::pause Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Headphones"},"i2s":true,"i2sid":{"value":"audiophonics-es9028q2m-dac","label":"Audiophonics I-Sabre ES9028Q2M"}} Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Found match in i2s Card Database: setting mixer Digital for card Audiophonics I-Sabre ES9028Q2M Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Disabling external Volume Control Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Enable softmixer device for audio device undefined Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Getting Alsa Cards List without I2S DAC Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Software Volume ALSA configuration written Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Preparing to generate the ALSA configuration file Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Reading ALSA contributions from plugins. Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Asound.conf file unchanged, so no further update is needed Jan 26 18:48:18 klipsch-volumio volumio[1072]: info: Output device has changed, restarting MPD Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:18 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:18 klipsch-volumio sudo[2681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 18:48:19 klipsch-volumio sudo[2681]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: Output device has changed, restarting Shairport Sync Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:19 klipsch-volumio sudo[2681]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 18:48:19 klipsch-volumio sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopping Music Player Daemon... Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio systemd[1]: mpd.service: Succeeded. Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopped Music Player Daemon. Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: QobuzConnect: setDeactiveState invoked Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:19 klipsch-volumio vtcs[2493]: [2026-01-26 18:48:19.074] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 26 18:48:19 klipsch-volumio vtcs[2493]: [2026-01-26 18:48:19.075] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Jan 26 18:48:19 klipsch-volumio vtcs[2493]: [2026-01-26 18:48:19.075] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 26 18:48:19 klipsch-volumio systemd[1]: Starting Music Player Daemon... Jan 26 18:48:19 klipsch-volumio sudo[2694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 18:48:19 klipsch-volumio sudo[2694]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio sudo[2697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 18:48:19 klipsch-volumio sudo[2697]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jan 26 18:48:19 klipsch-volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jan 26 18:48:19 klipsch-volumio systemd[1]: vtcs.service: Succeeded. Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 26 18:48:19 klipsch-volumio sudo[2694]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio sudo[2697]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:48:19 klipsch-volumio sudo[2691]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 18:48:19 klipsch-volumio sudo[2705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:48:19 klipsch-volumio sudo[2705]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio sudo[2691]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio sudo[2691]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: MPD Permissions set Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:19 klipsch-volumio sudo[2705]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio sudo[2709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 26 18:48:19 klipsch-volumio sudo[2709]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jan 26 18:48:19 klipsch-volumio qobuz-connect[2473]: 20260126 18:48:19.271 [2473.2473] INFO SampleApp: Stopping Local configuration server Jan 26 18:48:19 klipsch-volumio qobuz-connect[2473]: 20260126 18:48:19.283 [2473.2473] INFO SampleApp: shat down connection on UNIX socket Jan 26 18:48:19 klipsch-volumio systemd[1]: qobuz-connect.service: Succeeded. Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: QobuzConnect: setDeactiveState invoked Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: Starting Shairport Sync Jan 26 18:48:19 klipsch-volumio systemd[1]: Started Volumio Qobuz Connect Service. Jan 26 18:48:19 klipsch-volumio sudo[2709]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 26 18:48:19 klipsch-volumio sudo[2717]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: Executing endpoint qc_getconfig Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 26 18:48:19 klipsch-volumio systemd[1]: shairport-sync.service: Succeeded. Jan 26 18:48:19 klipsch-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 26 18:48:19 klipsch-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 26 18:48:19 klipsch-volumio sudo[2717]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.422 [2715.2715] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.426 [2715.2715] INFO VolumeManager: [0xf1e360]: Setting new playback volume: 75 Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.426 [2715.2715] INFO VolumeManager: [0xf1e360]: Setting new mute state: 0 Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.426 [2715.2715] INFO QobuzConnect: [0xf1ed30]: Client initialized! Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.426 [2715.2715] INFO SampleApp: Starting Avahi advertising, name: Klipsch Volumio, service name: _qobuz-connect._tcp Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:48:19 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: Shairport-Sync Started Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.442 [2715.2715] INFO LocalConfigManager: [0xf1dc40]: Starting Local Configuration server Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.442 [2715.2715] INFO SampleApp: Starting Local configuration server Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.443 [2715.2715] INFO SampleApp: Connected to UNIX socket client 0xf13f60 Jan 26 18:48:19 klipsch-volumio qobuz-connect[2715]: 20260126 18:48:19.571 [2715.2715] INFO SampleApp: Playback volume changed: 75 Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Jan 26 18:48:19 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:19 klipsch-volumio mpd[2708]: Jan 26 18:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 18:48:20 klipsch-volumio systemd[1]: Started Music Player Daemon. Jan 26 18:48:20 klipsch-volumio sudo[2685]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:20 klipsch-volumio volumio[1072]: error: updateQueue error: null Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: TidalConnect service stoped! Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: TidalConnect service stoped! Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 26 18:48:22 klipsch-volumio sudo[2737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 26 18:48:22 klipsch-volumio sudo[2737]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:22 klipsch-volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 26 18:48:22 klipsch-volumio sudo[2737]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: Executing endpoint tc_getconfig Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 26 18:48:22 klipsch-volumio vtcs[2739]: STARTING TidalConnect services, version: 1.5.2.56 Jan 26 18:48:22 klipsch-volumio vtcs[2739]: STARTED TidalConnect services. Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: Executing endpoint tc_connect Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: Connecting to TidalConnect Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: error: Could not process JSON: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::servicePushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: error: Could not process JSON: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::getcurrentVolume Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::updateTrackBlock Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrackBlock Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: VolumeController:: Volume=76 Mute =true Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:22 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jan 26 18:48:22 klipsch-volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jan 26 18:48:23 klipsch-volumio sudo[2763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 26 18:48:23 klipsch-volumio sudo[2763]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 18:48:23 klipsch-volumio systemd[1]: Stopping MPD Monitor Service... Jan 26 18:48:23 klipsch-volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 26 18:48:23 klipsch-volumio systemd[1]: mpd_monitor.service: Succeeded. Jan 26 18:48:23 klipsch-volumio systemd[1]: Stopped MPD Monitor Service. Jan 26 18:48:23 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 26 18:48:23 klipsch-volumio volumio[1072]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 26 18:48:23 klipsch-volumio systemd[1]: Started MPD Monitor Service. Jan 26 18:48:23 klipsch-volumio sudo[2763]: pam_unix(sudo:session): session closed for user root Jan 26 18:48:23 klipsch-volumio mpd_monitor.sh[2765]: MPD Monitor Service: Starting MPD Monitor Service Jan 26 18:48:23 klipsch-volumio volumio[1072]: info: Successfully started MPD Monitor Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:48:24 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:48:24 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:24 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:48:25 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:25 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:25 klipsch-volumio volumio[1072]: info: TidalConnect service started! Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:48:26 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:48:26 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:26 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:48:27 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:48:27 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:27 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPlay Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::play index undefined Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreStateMachine::startPlaybackTimer Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 18:48:30 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 26 18:48:30 klipsch-volumio volumio[1072]: verbose: MPD COMMAND [object Object] Jan 26 18:48:31 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue Jan 26 18:48:31 klipsch-volumio volumio[1072]: info: CoreStateMachine::getQueue Jan 26 18:48:31 klipsch-volumio volumio[1072]: info: CorePlayQueue::getQueue Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: Preload queue cleared Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::ClearQueue Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::stop Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::updateTrackBlock Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrackBlock Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::stPlaybackTimer Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreStateMachine::pushState Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 18:48:33 klipsch-volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Jan 26 18:48:33 klipsch-volumio volumio[1072]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 18:48:33 klipsch-volumio volumio[1072]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Jan 26 18:48:33 klipsch-volumio volumio[1072]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:182:10) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at /volumio/app/index.js:326:81 Jan 26 18:48:33 klipsch-volumio volumio[1072]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1256:12) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreStateMachine.clearQueue (/volumio/app/statemachine.js:277:8) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:494:21) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at Socket.emit (events.js:315:20) Jan 26 18:48:33 klipsch-volumio volumio[1072]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 26 18:48:33 klipsch-volumio volumio[1072]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jan 26 18:48:33 klipsch-volumio volumio[1072]: code: 'NumberExpected' Jan 26 18:48:33 klipsch-volumio volumio[1072]: } Jan 26 18:48:33 klipsch-volumio volumio[1072]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 18:48:33 klipsch-volumio sudo[2793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 18:47 Jan 26 18:48:33 klipsch-volumio sudo[2793]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"