-- Logs begin at Thu 2019-02-14 13:11:59 +03, end at Sun 2025-09-07 21:37:50 +03. --
Sep 07 21:36:00 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 07 21:36:00 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 07 21:36:00 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 07 21:36:01 volumio volumio-remote-updater[595]: No test mode
Sep 07 21:36:01 volumio volumio-remote-updater[595]: No alpha test mode
Sep 07 21:36:01 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Sep 07 21:36:01 volumio volumio[3451]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Sep 07 21:36:01 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Sep 07 21:36:01 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:36:01 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 07 21:36:02 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 07 21:36:03 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:04 volumio volumio[3451]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Sep 07 21:36:04 volumio volumio[3451]: info: Completed starting MyVolumio Plugin
Sep 07 21:36:04 volumio volumio[3451]: [Metrics] CommandRouter: 39s 995.73ms
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::volumiosetStartupVolume
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 07 21:36:04 volumio volumio[3451]: info: VolumeController:: Setting startup Volume 100
Sep 07 21:36:04 volumio volumio[3451]: info: VolumeController::SetAlsaVolume100
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::Close All Modals sent
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::Close All Modals sent
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 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
Sep 07 21:36:04 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:36:04 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 07 21:36:04 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:36:04 volumio volumio[3451]: info: [ASDebug] CurState: stop PrevState: stop
Sep 07 21:36:04 volumio volumio[3451]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command!
Sep 07 21:36:04 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
Sep 07 21:36:05 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 07 21:36:05 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 07 21:36:05 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 07 21:36:06 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 07 21:36:06 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 07 21:36:09 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:09 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
Sep 07 21:36:11 volumio volumio[3451]: info: BOOT COMPLETED
Sep 07 21:36:14 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:20 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:25 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:27 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 07 21:36:31 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:34 volumio volumio[3451]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/ampswitch/0.2.1/volumio/buster/armhf
Sep 07 21:36:36 volumio volumio[3451]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/ampswitch/0.2.1/volumio/buster/armhf
Sep 07 21:36:36 volumio volumio[3451]: info: Folder /tmp/plugins removed
Sep 07 21:36:36 volumio volumio[3451]: info: Check plugin dependencies
Sep 07 21:36:36 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 07 21:36:36 volumio volumio[3451]: info: Checking if plugin already exists
Sep 07 21:36:36 volumio volumio[3451]: info: An error occurred installing the plugin. Rolling back config
Sep 07 21:36:36 volumio volumio[3451]: info: Plugin folders cleanup
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning into folder /volumio/app/plugins/
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category audio_interface
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category miscellanea
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category music_service
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category plugins.json
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category system_controller
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category user_interface
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning into folder /data/plugins/
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category system_controller
Sep 07 21:36:36 volumio volumio[3451]: info: Scanning category user_interface
Sep 07 21:36:36 volumio volumio[3451]: info: Plugin folders cleanup completed
Sep 07 21:36:36 volumio volumio[3451]: info: Error: Error
Sep 07 21:36:36 volumio volumio[3451]: info: Folder /tmp/plugins removed
Sep 07 21:36:36 volumio volumio[3451]: info: Folder /tmp/downloaded_plugin.zip removed
Sep 07 21:36:36 volumio volumio[3451]: info: Folder /tmp/downloaded_plugin.zip removed
Sep 07 21:36:37 volumio volumio[3451]: info: Folder /data/temp removed
Sep 07 21:36:37 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:42 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:48 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:53 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:36:59 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:05 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:10 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:16 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:22 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:26 volumio volumio[3451]: info: Starting Uninstall of plugin system_controller - ampswitch
Sep 07 21:37:26 volumio volumio[3451]: info: Uninstalling plugin ampswitch
Sep 07 21:37:26 volumio volumio[3451]: info: [ASDebug] Port: 24
Sep 07 21:37:26 volumio volumio[3451]: info: [ASDebug] Inverted: false
Sep 07 21:37:26 volumio volumio[3451]: info: [ASDebug] Delay: 720
Sep 07 21:37:27 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:33 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:38 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:39 volumio sudo[4072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 07 21:37:39 volumio sudo[4072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 07 21:37:39 volumio sudo[4072]: pam_unix(sudo:session): session closed for user root
Sep 07 21:37:39 volumio sudo[4074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 07 21:37:39 volumio sudo[4074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 07 21:37:39 volumio sudo[4074]: pam_unix(sudo:session): session closed for user root
Sep 07 21:37:39 volumio volumio[3451]: verbose: New Socket.io Connection to 192.168.1.112 from 192.168.1.97 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 OPR/120.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 5
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:37:39 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 07 21:37:39 volumio volumio[3451]: info: Received Get System Info
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 07 21:37:39 volumio volumio[3451]: info: Discovery: Getting this device information
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:37:39 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:37:39 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:39 volumio volumio[3451]: info: Listing playlists
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 07 21:37:39 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 07 21:37:40 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 07 21:37:41 volumio volumio[3451]: info: Received Get System Info
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 07 21:37:41 volumio volumio[3451]: info: Discovery: Getting this device information
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:37:41 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 07 21:37:41 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 07 21:37:44 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:45 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 07 21:37:45 volumio volumio[3451]: info: Received Get System Info
Sep 07 21:37:45 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 07 21:37:45 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 07 21:37:45 volumio volumio[3451]: info: Discovery: Getting this device information
Sep 07 21:37:45 volumio volumio[3451]: info: CoreCommandRouter::volumioGetState
Sep 07 21:37:45 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:45 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 07 21:37:46 volumio volumio[3451]: info: CoreCommandRouter::volumioPlay
Sep 07 21:37:46 volumio volumio[3451]: info: CoreStateMachine::play index undefined
Sep 07 21:37:46 volumio volumio[3451]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 07 21:37:46 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:46 volumio volumio[3451]: info: CoreStateMachine::startPlaybackTimer
Sep 07 21:37:46 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:46 volumio volumio[3451]: info: [1757270266879] ControllerWebradio::clearAddPlayTrack
Sep 07 21:37:46 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand stop
Sep 07 21:37:46 volumio volumio[3451]: info: sendMpdCommand stop took 4 milliseconds
Sep 07 21:37:46 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand clear
Sep 07 21:37:46 volumio volumio[3451]: info:
Sep 07 21:37:46 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:46 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:46 volumio volumio[3451]: info: sendMpdCommand clear took 3 milliseconds
Sep 07 21:37:46 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand load "https://dorognoe.hostingradio.ru:443/radio"
Sep 07 21:37:46 volumio volumio[3451]: info:
Sep 07 21:37:46 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:46 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:46 volumio volumio[3451]: info:
Sep 07 21:37:46 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:46 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:46 volumio volumio[3451]: error: updateQueue error: null
Sep 07 21:37:46 volumio volumio[3451]: info: ------------------------------ 12ms
Sep 07 21:37:48 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand add "https://dorognoe.hostingradio.ru:443/radio"
Sep 07 21:37:48 volumio volumio[3451]: error: updateQueue error: null
Sep 07 21:37:48 volumio volumio[3451]: error: updateQueue error: null
Sep 07 21:37:48 volumio volumio[3451]: info: ------------------------------ 1653ms
Sep 07 21:37:48 volumio volumio[3451]: info: ------------------------------ 1651ms
Sep 07 21:37:48 volumio volumio[3451]: info:
Sep 07 21:37:48 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:48 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:48 volumio volumio[3451]: info: sendMpdCommand add "https://dorognoe.hostingradio.ru:443/radio" took 4 milliseconds
Sep 07 21:37:48 volumio volumio[3451]: info: CoreStateMachine::setConsumeUpdateService mpd
Sep 07 21:37:48 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand play
Sep 07 21:37:48 volumio volumio[3451]: info:
Sep 07 21:37:48 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:48 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:48 volumio volumio[3451]: info:
Sep 07 21:37:48 volumio volumio[3451]: ---------------------------- MPD announces system playlist update
Sep 07 21:37:48 volumio volumio[3451]: info: Ignoring MPD Status Update
Sep 07 21:37:48 volumio volumio[3451]: info: ------------------------------ 11ms
Sep 07 21:37:48 volumio volumio[3451]: info: sendMpdCommand play took 10 milliseconds
Sep 07 21:37:48 volumio volumio[3451]: info: ------------------------------ 9ms
Sep 07 21:37:48 volumio volumio[3451]: info: ------------------------------ 7ms
Sep 07 21:37:49 volumio volumio[3451]: info:
Sep 07 21:37:49 volumio volumio[3451]: ---------------------------- MPD announces state update: player
Sep 07 21:37:49 volumio volumio[3451]: info: ControllerMpd::getState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand status
Sep 07 21:37:49 volumio volumio[3451]: info:
Sep 07 21:37:49 volumio volumio[3451]: ---------------------------- MPD announces state update: player
Sep 07 21:37:49 volumio volumio[3451]: info: ControllerMpd::getState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand status
Sep 07 21:37:49 volumio volumio[3451]: info:
Sep 07 21:37:49 volumio volumio[3451]: ---------------------------- MPD announces state update: player
Sep 07 21:37:49 volumio volumio[3451]: info: ControllerMpd::getState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand status
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand status took 13 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand status took 13 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::parseState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::parseState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand status took 27 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand clearerror took 19 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand clearerror took 17 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand playlistinfo took 10 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: info: sendMpdCommand playlistinfo took 10 milliseconds
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::parseState
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::parseTrackInfo
Sep 07 21:37:49 volumio volumio[3451]: verbose: ControllerMpd::parseTrackInfo
Sep 07 21:37:49 volumio volumio[3451]: info: ControllerMpd::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::servicePushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:49 volumio volumio[3451]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio","artist":null,"album":null,"uri":"https://dorognoe.hostingradio.ru:443/radio","trackType":""}
Sep 07 21:37:49 volumio volumio[3451]: verbose: CURRENT POSITION 0
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::syncState stateService stop
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::syncState currentStatus stop
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: No code
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: ControllerMpd::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::servicePushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: CorePlayQueue::getTrack 0
Sep 07 21:37:49 volumio volumio[3451]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio","artist":null,"album":null,"uri":"https://dorognoe.hostingradio.ru:443/radio","trackType":""}
Sep 07 21:37:49 volumio volumio[3451]: verbose: CURRENT POSITION 0
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::syncState stateService stop
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::syncState currentStatus stop
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: No code
Sep 07 21:37:49 volumio volumio[3451]: info: CoreStateMachine::pushState
Sep 07 21:37:49 volumio volumio[3451]: info: CoreCommandRouter::volumioPushState
Sep 07 21:37:49 volumio volumio[3451]: info: ------------------------------ 111ms
Sep 07 21:37:49 volumio volumio[3451]: info: ------------------------------ 109ms
Sep 07 21:37:49 volumio volumio[3451]: info: [ASDebug] CurState: PrevState: stop
Sep 07 21:37:49 volumio volumio[3451]: info: [ASDebug] Togle GPIO: ON
Sep 07 21:37:49 volumio volumio[3451]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 07 21:37:49 volumio volumio[3451]: Error: EBADF: bad file descriptor, write
Sep 07 21:37:49 volumio volumio[3451]: at Object.writeSync (fs.js:711:3)
Sep 07 21:37:49 volumio volumio[3451]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8)
Sep 07 21:37:49 volumio volumio[3451]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23)
Sep 07 21:37:49 volumio volumio[3451]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86)
Sep 07 21:37:49 volumio volumio[3451]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Sep 07 21:37:49 volumio volumio[3451]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10)
Sep 07 21:37:49 volumio volumio[3451]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12)
Sep 07 21:37:49 volumio volumio[3451]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Sep 07 21:37:49 volumio volumio[3451]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Sep 07 21:37:49 volumio volumio[3451]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8)
Sep 07 21:37:49 volumio volumio[3451]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Sep 07 21:37:49 volumio volumio[3451]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20)
Sep 07 21:37:49 volumio volumio[3451]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12)
Sep 07 21:37:49 volumio volumio[3451]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16)
Sep 07 21:37:49 volumio volumio[3451]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15)
Sep 07 21:37:49 volumio volumio[3451]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) {
Sep 07 21:37:49 volumio volumio[3451]: errno: -9,
Sep 07 21:37:49 volumio volumio[3451]: syscall: 'write',
Sep 07 21:37:49 volumio volumio[3451]: code: 'EBADF'
Sep 07 21:37:49 volumio volumio[3451]: }
Sep 07 21:37:49 volumio volumio[3451]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 07 21:37:50 volumio wpa_supplicant[891]: wlan0: Failed to initiate sched scan
Sep 07 21:37:50 volumio sudo[4109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-07 21:36
Sep 07 21:37:50 volumio sudo[4109]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"