-- Logs begin at Mon 2024-08-26 18:01:57 UTC, end at Mon 2024-08-26 18:18:35 UTC. -- Aug 26 18:17:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:17:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:03 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:03 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:03 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:17:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 18:17:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 18:17:08 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:17:08 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:17:19 volumio volumio[1195]: info: Enabling plugin now_playing Aug 26 18:17:19 volumio volumio[1195]: info: Loading plugin "now_playing"... Aug 26 18:17:20 volumio volumio[1195]: info: PLUGIN START: now_playing Aug 26 18:17:20 volumio volumio[1195]: info: [now-playing] ConfigUpdater: config version unavailable. Either this is the first time the plugin is installed, or the previous version is < 0.3.0). Config will not be updated. Aug 26 18:17:20 volumio volumio[1195]: info: [now-playing] ConfigUpdater: updated config version to 0.7.3 Aug 26 18:17:20 volumio volumio[1195]: info: [now-playing] App is listening on port 4004. Aug 26 18:17:20 volumio volumio[1195]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Aug 26 18:17:20 volumio volumio[1195]: info: Done. Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:20 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:20 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:17:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:17:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:23 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:23 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:23 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:17:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:17:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:25 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:25 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:25 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:17:29 volumio volumio[1195]: info: CALLMETHOD: user_interface now_playing configSaveDaemon [object Object] Aug 26 18:17:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveDaemon Aug 26 18:17:43 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:17:43 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:43 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:43 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:43 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:43 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:17:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:17:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:17:55 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:17:55 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:17:55 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:17:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:00 volumio volumio[1195]: info: CALLMETHOD: user_interface now_playing configSaveStartupOptions [object Object] Aug 26 18:18:00 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveStartupOptions Aug 26 18:18:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:03 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:03 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:03 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:07 volumio sudo[3284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 18:18:07 volumio sudo[3284]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:07 volumio sudo[3284]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:07 volumio sudo[3287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 18:18:07 volumio sudo[3287]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:07 volumio sudo[3287]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:07 volumio volumio[1195]: verbose: New Socket.io Connection to 192.168.31.82 from 192.168.31.71 UA: Mozilla/5.0 (Linux; Android 14; 24030PN60G Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 26 18:18:07 volumio sudo[3290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 18:18:07 volumio sudo[3290]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:07 volumio sudo[3290]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:07 volumio sudo[3293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 18:18:07 volumio sudo[3293]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:07 volumio sudo[3293]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:07 volumio volumio[1195]: verbose: New Socket.io Connection to 192.168.31.82 from 192.168.31.71 UA: Mozilla/5.0 (Linux; Android 14; 24030PN60G Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:08 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 18:18:08 volumio volumio[1195]: info: Received Get System Info Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:08 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:08 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:08 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:08 volumio volumio[1195]: info: Listing playlists Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 18:18:08 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 18:18:09 volumio volumio[1195]: info: Received Get System Info Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:09 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:09 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 26 18:18:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 18:18:11 volumio volumio[1195]: info: Received Get System Info Aug 26 18:18:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:11 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:11 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:11 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:17 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 18:18:20 volumio volumio[1195]: info: Getting Alsa Cards List without I2S DAC Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:20 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 Aug 26 18:18:20 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 Aug 26 18:18:20 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 Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 18:18:20 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 18:18:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:23 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:23 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:23 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:23 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:25 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:25 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:25 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 18:18:26 volumio volumio[1195]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 26 18:18:26 volumio volumio[1195]: info: Received Get System Version Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 18:18:26 volumio volumio[1195]: info: Received Get System Info Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 18:18:26 volumio volumio[1195]: info: Discovery: Getting this device information Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:26 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 18:18:32 volumio volumio[1195]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 26 18:18:32 volumio volumio[1195]: info: Preparing to save Alsa Options, stopping services first Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:32 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::volumioPause Aug 26 18:18:32 volumio volumio[1195]: info: CoreStateMachine::pause Aug 26 18:18:32 volumio volumio[1195]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI 0 Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:32 volumio volumio[1195]: info: Enabling I2S DAC: HiFiBerry DAC Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:32 volumio sudo[3308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Aug 26 18:18:32 volumio sudo[3308]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:32 volumio sudo[3308]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:32 volumio sudo[3311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r gpio-irgpio_pin=25gpio_pull=up Aug 26 18:18:32 volumio sudo[3311]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:32 volumio sudo[3311]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:32 volumio volumio[1195]: * Overlay 'gpio-irgpio_pin=25gpio_pull=up' is not loaded Aug 26 18:18:32 volumio volumio[1195]: error: Cannot remove overlay Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:32 volumio sudo[3320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dac Aug 26 18:18:32 volumio sudo[3320]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:32 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2s@a0000/status Aug 26 18:18:32 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Aug 26 18:18:32 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Aug 26 18:18:32 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Aug 26 18:18:32 volumio sudo[3320]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:32 volumio volumio[1195]: warn: Unable to locate the device HDMI 0 Out a reboot may be required. Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:32 volumio volumio[1195]: info: Device 2 does not have any Mixer Control Available Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 26 18:18:32 volumio volumio[1195]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 26 18:18:32 volumio volumio[1195]: info: Disabling external Volume Control Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:32 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:32 volumio volumio[1195]: info: CoreStateMachine::pushState Aug 26 18:18:32 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 18:18:32 volumio volumio[1195]: info: CoreCommandRouter::volumioPushState Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 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: [0x00000020] -121 Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 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: [0x00000020] -121 Aug 26 18:18:32 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 Aug 26 18:18:32 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 Aug 26 18:18:32 volumio volumio[1195]: info: Preparing to generate the ALSA configuration file Aug 26 18:18:32 volumio volumio[1195]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 26 18:18:32 volumio volumio[1195]: info: PeppyMeterBasic ---peppymeterbasic status stop Aug 26 18:18:33 volumio volumio[1195]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Aug 26 18:18:33 volumio volumio[1195]: info: I2S Param [object Object] successfully enabled Aug 26 18:18:33 volumio volumio[1195]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 26 18:18:33 volumio volumio[1195]: info: Reading ALSA contributions from plugins. Aug 26 18:18:33 volumio sudo[3341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 26 18:18:33 volumio sudo[3341]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio sudo[3341]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 18:18:33 volumio volumio[1195]: info: Getting Alsa Cards List without I2S DAC Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 18:18:33 volumio volumio[1195]: info: peppymeterbasic Daemon Stop Aug 26 18:18:33 volumio volumio[1195]: info: Asound.conf file written Aug 26 18:18:33 volumio sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 18:18:33 volumio sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio sudo[3352]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 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: [0x00000020] -121 Aug 26 18:18:33 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 Aug 26 18:18:33 volumio volumio[1195]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Digital Playback Volume:0' : Remote I/O error Aug 26 18:18:33 volumio volumio[1195]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Digital Playback Switch:0' : Remote I/O error Aug 26 18:18:33 volumio volumio[1195]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:FIR Filter Type:0' : Invalid argument Aug 26 18:18:33 volumio volumio[1195]: info: Output device has changed, restarting MPD Aug 26 18:18:33 volumio sudo[3358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 18:18:33 volumio sudo[3358]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio sudo[3358]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio volumio[1195]: info: Output device has changed, restarting Shairport Sync Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio sudo[3361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 18:18:33 volumio sudo[3361]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio systemd[1]: Stopping Music Player Daemon... Aug 26 18:18:33 volumio systemd[1]: mpd.service: Succeeded. Aug 26 18:18:33 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 18:18:33 volumio volumio[1195]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 18:18:33 volumio volumio[1195]: info: Output device has changed, restarting MPD Aug 26 18:18:33 volumio sudo[3368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 18:18:33 volumio sudo[3368]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio volumio[1195]: info: Output device has changed, restarting Shairport Sync Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio sudo[3368]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio systemd[1]: Starting Music Player Daemon... Aug 26 18:18:33 volumio sudo[3371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 18:18:33 volumio sudo[3371]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 26 18:18:33 volumio systemd[1]: mpd.service: Succeeded. Aug 26 18:18:33 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 18:18:33 volumio systemd[1]: Starting Music Player Daemon... Aug 26 18:18:33 volumio volumio[1195]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 26 18:18:33 volumio volumio[1195]: info: MPD Permissions set Aug 26 18:18:33 volumio volumio[1195]: info: MPD Permissions set Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Aug 26 18:18:33 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio sudo[3377]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio sudo[3377]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio sudo[3377]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 18:18:33 volumio volumio[1195]: info: Starting Shairport Sync Aug 26 18:18:33 volumio volumio[1195]: info: Starting Shairport Sync Aug 26 18:18:33 volumio sudo[3389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 18:18:33 volumio sudo[3389]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 18:18:33 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 18:18:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 18:18:33 volumio sudo[3392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 18:18:33 volumio sudo[3392]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 18:18:33 volumio sudo[3389]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 18:18:33 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 26 18:18:33 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 18:18:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 18:18:33 volumio volumio[1195]: info: Shairport-Sync Started Aug 26 18:18:33 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 18:18:33 volumio sudo[3392]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio volumio[1195]: info: Shairport-Sync Started Aug 26 18:18:33 volumio mpd[3383]: Aug 26 18:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 26 18:18:33 volumio systemd[1]: Started Music Player Daemon. Aug 26 18:18:33 volumio sudo[3371]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio sudo[3361]: pam_unix(sudo:session): session closed for user root Aug 26 18:18:33 volumio volumio[1195]: error: MPD error: The expression evaluated to a falsy value: Aug 26 18:18:33 volumio volumio[1195]: assert.ok(self.idling) Aug 26 18:18:33 volumio volumio[1195]: error: The expression evaluated to a falsy value: Aug 26 18:18:33 volumio volumio[1195]: assert.ok(self.idling) Aug 26 18:18:33 volumio volumio[1195]: error: updateQueue error: null Aug 26 18:18:35 volumio volumio[1195]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 26 18:18:35 volumio volumio[1195]: info: PLUGIN onReboot : networkfs Aug 26 18:18:35 volumio volumio[1195]: info: PLUGIN onReboot : touch_display Aug 26 18:18:35 volumio volumio[1195]: info: PLUGIN onReboot : audiophonicsonoff Aug 26 18:18:35 volumio volumio[1195]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 18:18:35 volumio volumio[1195]: TypeError: Cannot read property 'writeSync' of undefined Aug 26 18:18:35 volumio volumio[1195]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 26 18:18:35 volumio volumio[1195]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 26 18:18:35 volumio volumio[1195]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 26 18:18:35 volumio volumio[1195]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 26 18:18:35 volumio volumio[1195]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 26 18:18:35 volumio volumio[1195]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 26 18:18:35 volumio volumio[1195]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Aug 26 18:18:35 volumio volumio[1195]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Aug 26 18:18:35 volumio volumio[1195]: at Socket.emit (events.js:315:20) Aug 26 18:18:35 volumio volumio[1195]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 26 18:18:35 volumio volumio[1195]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 26 18:18:35 volumio volumio[1195]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 18:18:35 volumio sudo[3402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Aug 26 18:18:35 volumio sudo[3402]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 18:18:35 volumio systemd[1]: Stopping Volumio Kiosk... Aug 26 18:18:35 volumio startx[1496]: xinit: connection to X server lost Aug 26 18:18:35 volumio startx[1496]: [1B blob data] Aug 26 18:18:35 volumio sudo[3414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 18:17 Aug 26 18:18:35 volumio sudo[3414]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"