Feb 22 09:07:00 volumio volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 09:07:00 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 22 09:07:00 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:00 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 09:07:00 volumio volumio[1178]: info: Getting Alsa Cards List without I2S DAC
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 22 09:07:01 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 09:07:07 volumio nmbd[1041]: [2026/02/22 09:07:07.485308, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Feb 22 09:07:07 volumio nmbd[1041]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.160.246 for name WORKGROUP<1d>.
Feb 22 09:07:07 volumio nmbd[1041]: This response was from IP 192.168.160.1, reporting an IP address of 192.168.160.1.
Feb 22 09:07:12 volumio volumio[1178]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Feb 22 09:07:12 volumio volumio[1178]: info: Preparing to save Alsa Options, stopping services first
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioPause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::servicePause
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::servicePause
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::pause
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand pause
Feb 22 09:07:12 volumio volumio[1178]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-digi","label":"HiFiBerry Digi"}}
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: Device 3 does not have any Mixer Control Available
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 22 09:07:12 volumio volumio[1178]: info: Updating Volume Controller Parameters: Device: 3 Name: HiFiBerry Digi Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 22 09:07:12 volumio volumio[1178]: info: Disabling external Volume Control
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:07:12 volumio volumio[1178]: info: Preparing to generate the ALSA configuration file
Feb 22 09:07:12 volumio volumio[1178]: info:
Feb 22 09:07:12 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand pause took 177 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:07:12 volumio volumio[1178]: info:
Feb 22 09:07:12 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:07:12 volumio volumio[1178]: info:
Feb 22 09:07:12 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand status took 10 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand status took 9 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand status took 7 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:07:12 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":48988,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:07:12 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState stateService pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":48988,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:07:12 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState stateService pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 22 09:07:12 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":48988,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:07:12 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState stateService pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:07:12 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:07:12 volumio volumio[1178]: info: CoreStateMachine::stPlaybackTimer
Feb 22 09:07:12 volumio volumio[1178]: info: ------------------------------ 65ms
Feb 22 09:07:12 volumio volumio[1178]: info: ------------------------------ 63ms
Feb 22 09:07:12 volumio volumio[1178]: info: ------------------------------ 61ms
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 09:07:12 volumio volumio[1178]: info: Getting Alsa Cards List without I2S DAC
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 09:07:12 volumio volumio[1178]: info: Asound.conf file unchanged, so no further update is needed
Feb 22 09:07:12 volumio volumio[1178]: info: Output device has changed, restarting MPD
Feb 22 09:07:12 volumio volumio[1178]: info: Output device has changed, restarting Shairport Sync
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio sudo[2355]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 22 09:07:12 volumio sudo[2355]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 09:07:12 volumio sudo[2357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 22 09:07:12 volumio sudo[2357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 09:07:12 volumio sudo[2355]: pam_unix(sudo:session): session closed for user root
Feb 22 09:07:12 volumio volumio[1178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 22 09:07:12 volumio volumio[1178]: info: MPD Permissions set
Feb 22 09:07:12 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 09:07:12 volumio volumio[1178]: info: Starting Shairport Sync
Feb 22 09:07:12 volumio sudo[2371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 22 09:07:12 volumio sudo[2371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 09:07:12 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 22 09:07:12 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 22 09:07:12 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 09:07:12 volumio systemd[1]: shairport-sync.service: Consumed 2.535s CPU time.
Feb 22 09:07:12 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 09:07:12 volumio sudo[2371]: pam_unix(sudo:session): session closed for user root
Feb 22 09:07:12 volumio volumio[1178]: info: Shairport-Sync Started
Feb 22 09:07:13 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 22 09:07:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 22 09:07:13 volumio systemd[1]: mpd.service: Consumed 7.216s CPU time.
Feb 22 09:07:13 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 22 09:07:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 22 09:07:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 22 09:07:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 22 09:07:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 22 09:07:13 volumio upmpdcli[1635]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0
Feb 22 09:07:13 volumio sudo[2390]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 22 09:07:13 volumio sudo[2390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 09:07:13 volumio sudo[2390]: pam_unix(sudo:session): session closed for user root
Feb 22 09:07:16 volumio mpd[2392]: 2026-02-22T09:07:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 22 09:07:16 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 22 09:07:16 volumio sudo[2357]: pam_unix(sudo:session): session closed for user root
Feb 22 09:07:16 volumio upmpdcli[1635]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started
Feb 22 09:07:16 volumio volumio[1178]: error: updateQueue error: null
Feb 22 09:07:16 volumio volumio[1178]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Feb 22 09:07:16 volumio volumio[1178]: info: CoreStateMachine::getcurrentVolume
Feb 22 09:07:16 volumio volumio[1178]: info: CoreCommandRouter::volumioRetrievevolume
Feb 22 09:07:16 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:07:16 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:07:16 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:07:54 volumio ntpd[919]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Feb 22 09:08:14 volumio upmpdcli[1635]: :3:../src/upmpd.cxx:298::checkContentFormat: format check disabled
Feb 22 09:08:14 volumio volumio[1178]: info:
Feb 22 09:08:14 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 22 09:08:14 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 22 09:08:14 volumio volumio[1178]: error: updateQueue error: null
Feb 22 09:08:14 volumio volumio[1178]: info: ------------------------------ 4ms
Feb 22 09:08:14 volumio volumio[1178]: info:
Feb 22 09:08:14 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 22 09:08:14 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 22 09:08:14 volumio volumio[1178]: info:
Feb 22 09:08:14 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 22 09:08:14 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 22 09:08:14 volumio volumio[1178]: info: ------------------------------ 3ms
Feb 22 09:08:14 volumio volumio[1178]: info: ------------------------------ 3ms
Feb 22 09:08:14 volumio volumio[1178]: info:
Feb 22 09:08:14 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:08:14 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:08:14 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error!
Feb 22 09:08:14 volumio volumio[1178]: info:
Feb 22 09:08:14 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:08:14 volumio volumio[1178]: info: sendMpdCommand status took 7 milliseconds
Feb 22 09:08:14 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:08:14 volumio volumio[1178]: info: sendMpdCommand status took 2 milliseconds
Feb 22 09:08:14 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:08:14 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:08:14 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:14 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享 (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:08:14 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:08:14 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:08:14 volumio volumio[1178]: info: ------------------------------ 34ms
Feb 22 09:08:14 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 22 09:08:14 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:08:14 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:08:14 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:14 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享 (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:08:14 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 22 09:08:14 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:08:14 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:08:14 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:08:14 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:14 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:08:14 volumio volumio[1178]: info: ------------------------------ 54ms
Feb 22 09:08:15 volumio volumio[1178]: info:
Feb 22 09:08:15 volumio volumio[1178]: ---------------------------- MPD announces system playlist update
Feb 22 09:08:15 volumio volumio[1178]: info: Ignoring MPD Status Update
Feb 22 09:08:15 volumio volumio[1178]: info:
Feb 22 09:08:15 volumio volumio[1178]: ---------------------------- MPD announces state update: player
Feb 22 09:08:15 volumio volumio[1178]: info: ControllerMpd::getState
Feb 22 09:08:15 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 09:08:15 volumio volumio[1178]: info: ------------------------------ 4ms
Feb 22 09:08:15 volumio volumio[1178]: info: sendMpdCommand status took 3 milliseconds
Feb 22 09:08:15 volumio volumio[1178]: verbose: ControllerMpd::parseState
Feb 22 09:08:15 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 09:08:15 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 22 09:08:15 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Feb 22 09:08:15 volumio volumio[1178]: info: ControllerMpd::pushState
Feb 22 09:08:15 volumio volumio[1178]: info: CoreCommandRouter::servicePushState
Feb 22 09:08:15 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:15 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"《环太平洋》主题曲MV","artist":"like资源分享","album":null,"uri":"http://lv.sycdn.kuwo.cn/976471d41da931dd1819c2ad9fdba475/699a568f/resource/30106/trackmedia/M500001EeebA2EEnKt.mp3","trackType":"mp3"}
Feb 22 09:08:15 volumio volumio[1178]: verbose: CURRENT POSITION 0
Feb 22 09:08:15 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play
Feb 22 09:08:15 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Feb 22 09:08:15 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload
Feb 22 09:08:15 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:08:15 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:15 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 09:08:15 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:08:15 volumio volumio[1178]: info: CoreStateMachine::pushState
Feb 22 09:08:15 volumio volumio[1178]: info: CorePlayQueue::getTrack 0
Feb 22 09:08:15 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState
Feb 22 09:08:15 volumio volumio[1178]: info: ------------------------------ 34ms
Feb 22 09:08:23 volumio volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 09:08:23 volumio volumio[1178]: Error: connect ETIMEDOUT 108.160.162.98:443
Feb 22 09:08:23 volumio volumio[1178]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Feb 22 09:08:23 volumio volumio[1178]: errno: -110,
Feb 22 09:08:23 volumio volumio[1178]: code: 'ETIMEDOUT',
Feb 22 09:08:23 volumio volumio[1178]: syscall: 'connect',
Feb 22 09:08:23 volumio volumio[1178]: address: '108.160.162.98',
Feb 22 09:08:23 volumio volumio[1178]: port: 443
Feb 22 09:08:23 volumio volumio[1178]: }
Feb 22 09:08:23 volumio volumio[1178]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 09:08:24 volumio sudo[2534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 09:07'
Feb 22 09:08:24 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"