-- Logs begin at Tue 2025-05-27 21:29:26 HKT, end at Tue 2025-05-27 21:35:02 HKT. -- May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 27 21:34:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 27 21:34:06 volumio volumio[877]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 27 21:34:06 volumio volumio[877]: info: Preparing to save Alsa Options, stopping services first May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::volumioGetState May 27 21:34:06 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::volumioPause May 27 21:34:06 volumio volumio[877]: info: CoreStateMachine::pause May 27 21:34:06 volumio volumio[877]: info: Saving Audio Output to: {"output_device":{"value":"0,0","label":"Analog Out"}} May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 21:34:06 volumio volumio[877]: info: Found match in Cards Database: setting mixer for card Analog Out May 27 21:34:06 volumio volumio[877]: info: Setting mixer Master for card Analog Out May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 27 21:34:06 volumio volumio[877]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 27 21:34:06 volumio volumio[877]: info: Disabling external Volume Control May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 21:34:06 volumio volumio[877]: info: Preparing to generate the ALSA configuration file May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 27 21:34:06 volumio volumio[877]: info: Asound.conf file unchanged, so no further update is needed May 27 21:34:06 volumio volumio[877]: info: Output device has changed, restarting MPD May 27 21:34:06 volumio sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 27 21:34:06 volumio sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 21:34:06 volumio volumio[877]: info: Output device has changed, restarting Shairport Sync May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 21:34:06 volumio sudo[3157]: pam_unix(sudo:session): session closed for user root May 27 21:34:06 volumio sudo[3160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 27 21:34:06 volumio sudo[3160]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 21:34:06 volumio systemd[1]: Stopping Music Player Daemon... May 27 21:34:06 volumio volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 21:34:06 volumio systemd[1]: mpd.service: Succeeded. May 27 21:34:06 volumio systemd[1]: Stopped Music Player Daemon. May 27 21:34:06 volumio volumio[877]: info: MPD Permissions set May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 21:34:06 volumio volumio[877]: info: VolumeController:: Volume=49 Mute =false May 27 21:34:06 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:06 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 21:34:06 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:06 volumio systemd[1]: Starting Music Player Daemon... May 27 21:34:06 volumio volumio[877]: info: Starting Shairport Sync May 27 21:34:06 volumio sudo[3174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 21:34:06 volumio sudo[3174]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 21:34:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 27 21:34:06 volumio systemd[1]: shairport-sync.service: Succeeded. May 27 21:34:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 27 21:34:06 volumio sudo[3165]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 27 21:34:06 volumio sudo[3165]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 21:34:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 27 21:34:06 volumio sudo[3174]: pam_unix(sudo:session): session closed for user root May 27 21:34:06 volumio sudo[3165]: pam_unix(sudo:session): session closed for user root May 27 21:34:06 volumio volumio[877]: info: Shairport-Sync Started May 27 21:34:06 volumio mpd[3178]: May 27 21:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 27 21:34:06 volumio systemd[1]: Started Music Player Daemon. May 27 21:34:06 volumio sudo[3160]: pam_unix(sudo:session): session closed for user root May 27 21:34:06 volumio volumio[877]: error: updateQueue error: null May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioGetState May 27 21:34:10 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 27 21:34:10 volumio volumio[877]: info: CoreStateMachine::getcurrentVolume May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioRetrievevolume May 27 21:34:10 volumio volumio[877]: info: VolumeController:: Volume=49 Mute =false May 27 21:34:10 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:10 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:10 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock May 27 21:34:10 volumio volumio[877]: info: CorePlayQueue::getTrackBlock May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioRetrievevolume May 27 21:34:10 volumio volumio[877]: info: VolumeController:: Volume=49 Mute =false May 27 21:34:10 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:10 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:10 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 27 21:34:17 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 27 21:34:20 volumio volumio[877]: info: CoreCommandRouter::volumioGetState May 27 21:34:20 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:23 volumio volumio[877]: info: Preload queue cleared May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::ClearQueue May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::stop May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrackBlock May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::stPlaybackTimer May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::serviceStop May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 1 May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::serviceStop May 27 21:34:23 volumio volumio[877]: info: ControllerMpd::stop May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand stop May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::clearPlayQueue May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::saveQueue May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPushQueue May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::addQueueItems May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::addQueueItems May 27 21:34:23 volumio volumio[877]: info: Preload queue cleared May 27 21:34:23 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.[All.The.Way.A.Decade.Of.Song.CDImage]/[席琳狄翁·天长地久的情歌].Celine.Dion.-.[All.The.Way.A.Decade.Of.Song].flac May 27 21:34:23 volumio volumio[877]: info: Using cached record of: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.[All.The.Way.A.Decade.Of.Song.CDImage]/[席琳狄翁·天长地久的情歌].Celine.Dion.-.[All.The.Way.A.Decade.Of.Song].flac May 27 21:34:23 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.A New Day Has Come 新的一天来临 (2002年)/Celine.Dion.-.A New Day Has Come 新的一天来临 (2002年).flac May 27 21:34:23 volumio volumio[877]: info: Using cached record of: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.A New Day Has Come 新的一天来临 (2002年)/Celine.Dion.-.A New Day Has Come 新的一天来临 (2002年).flac May 27 21:34:23 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD1 Let’s Talk About Love 说爱 (1997年)/CD1 Let’s Talk About Love 说爱 (1997年).flac May 27 21:34:23 volumio volumio[877]: info: Using cached record of: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD1 Let’s Talk About Love 说爱 (1997年)/CD1 Let’s Talk About Love 说爱 (1997年).flac May 27 21:34:23 volumio volumio[877]: info: Adding Item to queue: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac May 27 21:34:23 volumio volumio[877]: info: Using cached record of: music-library/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPushQueue May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::saveQueue May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::updateTrackBlock May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrackBlock May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPlay May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::play index 3 May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::stop May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::play index undefined May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::startPlaybackTimer May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::clearAddPlayTracks NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand stop May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand stop took 10 milliseconds May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand stop took 1 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand clear May 27 21:34:23 volumio volumio[877]: info: May 27 21:34:23 volumio volumio[877]: ---------------------------- MPD announces system playlist update May 27 21:34:23 volumio volumio[877]: info: Ignoring MPD Status Update May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand clear took 0 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand add "NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac" May 27 21:34:23 volumio volumio[877]: error: updateQueue error: null May 27 21:34:23 volumio volumio[877]: info: May 27 21:34:23 volumio volumio[877]: ---------------------------- MPD announces system playlist update May 27 21:34:23 volumio volumio[877]: info: Ignoring MPD Status Update May 27 21:34:23 volumio volumio[877]: info: ------------------------------ 1ms May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand add "NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac" took 1 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand play May 27 21:34:23 volumio volumio[877]: info: ------------------------------ 1ms May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand play took 0 milliseconds May 27 21:34:23 volumio volumio[877]: info: May 27 21:34:23 volumio volumio[877]: ---------------------------- MPD announces state update: player May 27 21:34:23 volumio volumio[877]: info: ControllerMpd::getState May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status May 27 21:34:23 volumio volumio[877]: info: May 27 21:34:23 volumio volumio[877]: ---------------------------- MPD announces state update: player May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand status took 23 milliseconds May 27 21:34:23 volumio volumio[877]: info: ControllerMpd::getState May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::parseState May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand status took 1 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::parseState May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand playlistinfo took 2 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo May 27 21:34:23 volumio volumio[877]: info: ControllerMpd::pushState May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::servicePushState May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4030,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"588 Kbps","isStreaming":false,"title":"CD2 Falling Into You 钟爱你 (1996年).flac","artist":null,"album":null,"uri":"NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac","trackType":"flac"} May 27 21:34:23 volumio volumio[877]: verbose: CURRENT POSITION 3 May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::syncState stateService play May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus stop May 27 21:34:23 volumio volumio[877]: info: ------------------------------ 27ms May 27 21:34:23 volumio volumio[877]: info: sendMpdCommand playlistinfo took 2 milliseconds May 27 21:34:23 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo May 27 21:34:23 volumio volumio[877]: info: ControllerMpd::pushState May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::servicePushState May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":865,"duration":4030,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"580 Kbps","isStreaming":false,"title":"CD2 Falling Into You 钟爱你 (1996年).flac","artist":null,"album":null,"uri":"NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac","trackType":"flac"} May 27 21:34:23 volumio volumio[877]: verbose: CURRENT POSITION 3 May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::syncState stateService play May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play May 27 21:34:23 volumio volumio[877]: info: Received an update from plugin. extracting info from payload May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:23 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:23 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:23 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:23 volumio volumio[877]: info: ------------------------------ 13ms May 27 21:34:27 volumio volumio[877]: info: CoreCommandRouter::volumioGetState May 27 21:34:27 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::volumioSeek May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::seek May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: TRACKBLOCK {"uri":"mnt/NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac","service":"mpd","name":"CD2 Falling Into You 钟爱你 (1996年).flac","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=415&web=//extralarge&path=%2FNAS%2Fchjabr2%2F%5B%E5%B8%AD%E7%90%B3%E7%8B%84%E7%BF%81%5D%20Celine.Dion%2FCeline.Dion.-.Let%E2%80%99s%20Talk%20About%20Love%2FCD2%20Falling%20Into%20You%20%E9%92%9F%E7%88%B1%E4%BD%A0%20(1996%E5%B9%B4)&metadata=false","duration":4030,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::startPlaybackTimer May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: ControllerMpd::seek May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:28 volumio volumio[877]: error: null May 27 21:34:28 volumio volumio[877]: info: May 27 21:34:28 volumio volumio[877]: ---------------------------- MPD announces state update: player May 27 21:34:28 volumio volumio[877]: info: ControllerMpd::getState May 27 21:34:28 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand status May 27 21:34:28 volumio volumio[877]: info: sendMpdCommand status took 0 milliseconds May 27 21:34:28 volumio volumio[877]: verbose: ControllerMpd::parseState May 27 21:34:28 volumio volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 27 21:34:28 volumio volumio[877]: info: sendMpdCommand playlistinfo took 0 milliseconds May 27 21:34:28 volumio volumio[877]: verbose: ControllerMpd::parseTrackInfo May 27 21:34:28 volumio volumio[877]: info: ControllerMpd::pushState May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::servicePushState May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1286000,"duration":4030,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"CD2 Falling Into You 钟爱你 (1996年).flac","artist":null,"album":null,"uri":"NAS/chjabr2/[席琳狄翁] Celine.Dion/Celine.Dion.-.Let’s Talk About Love/CD2 Falling Into You 钟爱你 (1996年)/CD2 Falling Into You 钟爱你 (1996年).flac","trackType":"flac"} May 27 21:34:28 volumio volumio[877]: verbose: CURRENT POSITION 3 May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::syncState stateService play May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::syncState currentStatus play May 27 21:34:28 volumio volumio[877]: info: Received an update from plugin. extracting info from payload May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:28 volumio volumio[877]: info: CoreStateMachine::pushState May 27 21:34:28 volumio volumio[877]: info: CorePlayQueue::getTrack 3 May 27 21:34:28 volumio volumio[877]: info: CoreCommandRouter::volumioPushState May 27 21:34:28 volumio volumio[877]: info: ------------------------------ 5ms May 27 21:35:01 volumio volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 21:35:01 volumio volumio[877]: Error: connect ETIMEDOUT 199.59.148.20:80 May 27 21:35:01 volumio volumio[877]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 27 21:35:01 volumio volumio[877]: errno: -110, May 27 21:35:01 volumio volumio[877]: code: 'ETIMEDOUT', May 27 21:35:01 volumio volumio[877]: syscall: 'connect', May 27 21:35:01 volumio volumio[877]: address: '199.59.148.20', May 27 21:35:01 volumio volumio[877]: port: 80 May 27 21:35:01 volumio volumio[877]: } May 27 21:35:01 volumio volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 21:35:02 volumio sudo[3330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-27 21:34 May 27 21:35:02 volumio sudo[3330]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"