-- Logs begin at Tue 2024-04-23 10:40:31 CST, end at Tue 2024-04-23 15:57:49 CST. -- Apr 23 15:56:03 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ALLAN%20TAYLOR/692644a4-654b-4cfd-999f-fcdab27a8afa.jpg' Apr 23 15:56:03 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ARGERICH/87a5d94a-d770-4710-aa0b-3c078e06aa19.jpg' Apr 23 15:56:03 volumio volumio[730]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 23 15:56:03 volumio volumio[730]: info: Setting mixer PCM for card HM Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 23 15:56:03 volumio volumio[730]: info: Updating Volume Controller Parameters: Device: 5 Name: HM Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 23 15:56:03 volumio volumio[730]: info: Disabling external Volume Control Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:56:03 volumio volumio[730]: info: Preparing to generate the ALSA configuration file Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 23 15:56:03 volumio volumio[730]: info: VolumeController:: Volume=39 Mute =false Apr 23 15:56:03 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:03 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 15:56:03 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:07 volumio volumio[730]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 23 15:56:07 volumio volumio[730]: info: CoreStateMachine::getcurrentVolume Apr 23 15:56:07 volumio volumio[730]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 15:56:07 volumio volumio[730]: info: Asound.conf file written Apr 23 15:56:07 volumio sudo[1694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 23 15:56:07 volumio sudo[1694]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:09 volumio sudo[1694]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:10 volumio volumio[730]: Found hardware: "HDA-Intel" "Realtek ALC269VB" "HDA:10ec0269,102804ad,00100100" "0x1028" "0x04ad" Apr 23 15:56:10 volumio volumio[730]: Hardware is initialized using a generic method Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #1 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #2 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #3 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #4 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #5 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #6 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #7 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #8 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #9 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #12 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #19 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #20 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #22 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #23 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #26 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #27 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #30 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #35 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #41 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #42 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #43 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #44 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #45 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #46 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #47 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #48 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #49 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #50 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #51 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #52 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #53 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #54 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #55 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #56 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #57 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #58 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #59 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #60 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #61 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #62 (No such file or directory) Apr 23 15:56:10 volumio volumio[730]: No state is present for card NVidia Apr 23 15:56:10 volumio volumio[730]: Found hardware: "HDA-Intel" "Nvidia GPU 81 HDMI/DP" "HDA:10de0081,104385f5,00100100" "0x1043" "0x85f5" Apr 23 15:56:10 volumio volumio[730]: Hardware is initialized using a generic method Apr 23 15:56:10 volumio volumio[730]: No state is present for card NVidia Apr 23 15:56:10 volumio volumio[730]: No state is present for card Live Apr 23 15:56:10 volumio volumio[730]: Found hardware: "EMU10K1" "TriTech TR28023" "AC97a:54524103" "0x1102" "0x0021" Apr 23 15:56:10 volumio volumio[730]: Hardware is initialized using a generic method Apr 23 15:56:10 volumio volumio[730]: No state is present for card Live Apr 23 15:56:10 volumio volumio[730]: No state is present for card HM Apr 23 15:56:10 volumio volumio[730]: Found hardware: "USB-Audio" "USB Mixer" "USB262a:1560" "" "" Apr 23 15:56:10 volumio volumio[730]: Hardware is initialized using a generic method Apr 23 15:56:10 volumio volumio[730]: No state is present for card HM Apr 23 15:56:10 volumio volumio[730]: info: Output device has changed, restarting MPD Apr 23 15:56:10 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 15:56:10 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:10 volumio volumio[730]: info: Output device has changed, restarting Shairport Sync Apr 23 15:56:10 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:10 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:10 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:56:10 volumio sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 15:56:10 volumio sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:10 volumio systemd[1]: Stopping Music Player Daemon... Apr 23 15:56:10 volumio volumio[730]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 15:56:10 volumio volumio[730]: info: Output device has changed, restarting MPD Apr 23 15:56:10 volumio sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 15:56:10 volumio sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:10 volumio sudo[1708]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:10 volumio volumio[730]: info: Output device has changed, restarting Shairport Sync Apr 23 15:56:10 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:10 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:56:10 volumio sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 15:56:10 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:10 volumio volumio[730]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 23 15:56:10 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Abacab/1416241d-b689-4415-b1ec-36653c293bcd.jpg' Apr 23 15:56:11 volumio volumio[730]: info: MPD Permissions set Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:56:11 volumio volumio[730]: info: VolumeController:: Volume=39 Mute =false Apr 23 15:56:11 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:11 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:11 volumio volumio[730]: info: CoreStateMachine::updateTrackBlock Apr 23 15:56:11 volumio volumio[730]: info: CorePlayQueue::getTrackBlock Apr 23 15:56:11 volumio volumio[730]: info: CoreCommandRouter::volumioRetrievevolume Apr 23 15:56:14 volumio volumio[730]: info: Starting Shairport Sync Apr 23 15:56:14 volumio volumio[730]: info: Starting Shairport Sync Apr 23 15:56:14 volumio sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 15:56:14 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:14 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/e6b1eee3-bf3c-4391-9d22-a32845cc48c9.jpg' Apr 23 15:56:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 15:56:14 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 15:56:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 15:56:14 volumio sudo[1737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 23 15:56:14 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:56:14 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 23 15:56:14 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 15:56:14 volumio volumio[730]: info: VolumeController:: Volume=39 Mute =false Apr 23 15:56:14 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:14 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:14 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:14 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 23 15:56:14 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 23 15:56:14 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 23 15:56:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 23 15:56:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 23 15:56:14 volumio sudo[1737]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:16 volumio volumio[730]: info: Shairport-Sync Started Apr 23 15:56:16 volumio volumio[730]: info: Shairport-Sync Started Apr 23 15:56:17 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aimer(%E3%82%A8%E3%83%A1)/0ec4b9b3-f856-4c7b-813d-f4eb894a8b98.jpg' Apr 23 15:56:20 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Air%20Supply/e0638914-3808-4b49-a221-05ae7323988b.jpg' Apr 23 15:56:23 volumio systemd[1]: mpd.service: Succeeded. Apr 23 15:56:23 volumio systemd[1]: Stopped Music Player Daemon. Apr 23 15:56:23 volumio systemd[1]: Starting Music Player Daemon... Apr 23 15:56:23 volumio mpd[1744]: Apr 23 15:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 15:56:23 volumio systemd[1]: Started Music Player Daemon. Apr 23 15:56:23 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:23 volumio sudo[1702]: pam_unix(sudo:session): session closed for user root Apr 23 15:56:25 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alan%20Tam/605f7540-1f7f-4a68-92f7-7dfe98e91ccc.jpg' Apr 23 15:56:25 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alex%20To/980910b3-d89c-4e92-aa52-29a1c6ad64f9.jpg' Apr 23 15:56:26 volumio volumio[730]: error: MPD error: The expression evaluated to a falsy value: Apr 23 15:56:26 volumio volumio[730]: assert.ok(self.idling) Apr 23 15:56:26 volumio volumio[730]: error: The expression evaluated to a falsy value: Apr 23 15:56:26 volumio volumio[730]: assert.ok(self.idling) Apr 23 15:56:26 volumio volumio[730]: error: updateQueue error: null Apr 23 15:56:30 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alice%20Sara%20Ott/08d22505-4fee-4390-b3f5-3643d3541628.jpg' Apr 23 15:56:31 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Allan%20Taylor/41ccb967-04a1-40b7-95af-c2567be20e59.jpg' Apr 23 15:56:32 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Amadeus/426b93ea-08fc-4ad2-95f7-0147fac8e09f.jpg' Apr 23 15:56:35 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrew%20Manze/fb818b63-cfd6-442f-bf79-fdcb460249eb.jpg' Apr 23 15:56:39 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Angelita/37108308-b1a2-4f46-9097-01004a749c97.jpg' Apr 23 15:56:40 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Angelita%20Li/a6f9635d-8208-4cb5-8f3a-f4f06a90a91d.jpg' Apr 23 15:56:41 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anita%20Mui/66948320-edd6-47ec-a368-c96de51a3957.jpg' Apr 23 15:56:41 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Annalisa/218dc876-3849-4a45-bbd8-b3ca6dd09468.jpg' Apr 23 15:56:48 volumio volumio[730]: info: Preload queue cleared Apr 23 15:56:48 volumio volumio[730]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::ClearQueue Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::stop Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::clearPlayQueue Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::saveQueue Apr 23 15:56:48 volumio volumio[730]: info: CoreCommandRouter::volumioPushQueue Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::addQueueItems Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::addQueueItems Apr 23 15:56:48 volumio volumio[730]: info: Preload queue cleared Apr 23 15:56:48 volumio volumio[730]: info: Adding Item to queue: albums://Sally%20Yeh%20-%20SACD%20Collection/Sally%20Yeh%20-%20SACD%20Collection Apr 23 15:56:48 volumio volumio[730]: info: Exploding uri albums://Sally%20Yeh%20-%20SACD%20Collection/Sally%20Yeh%20-%20SACD%20Collection in service mpd Apr 23 15:56:48 volumio volumio[730]: info: CoreCommandRouter::volumioPushQueue Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::saveQueue Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::updateTrackBlock Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::getTrackBlock Apr 23 15:56:48 volumio volumio[730]: info: CoreCommandRouter::volumioPlay Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::play index 0 Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::stop Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::play index undefined Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:48 volumio volumio[730]: info: CoreStateMachine::startPlaybackTimer Apr 23 15:56:48 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:48 volumio volumio[730]: verbose: ControllerMpd::clearAddPlayTracks NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf Apr 23 15:56:48 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand stop Apr 23 15:56:48 volumio volumio[730]: info: sendMpdCommand stop took 42 milliseconds Apr 23 15:56:48 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand clear Apr 23 15:56:48 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Arne%20Domn%C3%A9rus/91c01e57-e63f-4751-83ee-974264f9dfe0.jpg' Apr 23 15:56:48 volumio volumio[730]: info: Apr 23 15:56:48 volumio volumio[730]: ---------------------------- MPD announces system playlist update Apr 23 15:56:48 volumio volumio[730]: info: Ignoring MPD Status Update Apr 23 15:56:48 volumio volumio[730]: info: sendMpdCommand clear took 3 milliseconds Apr 23 15:56:48 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand add "NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf" Apr 23 15:56:48 volumio volumio[730]: info: Apr 23 15:56:48 volumio volumio[730]: ---------------------------- MPD announces system playlist update Apr 23 15:56:48 volumio volumio[730]: info: Ignoring MPD Status Update Apr 23 15:56:48 volumio volumio[730]: error: updateQueue error: null Apr 23 15:56:48 volumio volumio[730]: info: Apr 23 15:56:48 volumio volumio[730]: ---------------------------- MPD announces system playlist update Apr 23 15:56:48 volumio volumio[730]: info: Ignoring MPD Status Update Apr 23 15:56:48 volumio volumio[730]: info: ------------------------------ 3ms Apr 23 15:56:48 volumio volumio[730]: info: sendMpdCommand add "NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf" took 2 milliseconds Apr 23 15:56:48 volumio volumio[730]: info: ------------------------------ 2ms Apr 23 15:56:48 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand play Apr 23 15:56:48 volumio volumio[730]: info: Apr 23 15:56:48 volumio volumio[730]: ---------------------------- MPD announces system playlist update Apr 23 15:56:48 volumio volumio[730]: info: Ignoring MPD Status Update Apr 23 15:56:48 volumio volumio[730]: info: ------------------------------ 3ms Apr 23 15:56:48 volumio volumio[730]: info: sendMpdCommand play took 2 milliseconds Apr 23 15:56:48 volumio volumio[730]: info: ------------------------------ 2ms Apr 23 15:56:49 volumio volumio[730]: info: Apr 23 15:56:49 volumio volumio[730]: ---------------------------- MPD announces state update: player Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::getState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand status Apr 23 15:56:49 volumio volumio[730]: info: Apr 23 15:56:49 volumio volumio[730]: ---------------------------- MPD announces state update: player Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::getState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand status Apr 23 15:56:49 volumio volumio[730]: info: Apr 23 15:56:49 volumio volumio[730]: ---------------------------- MPD announces state update: player Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::getState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand status Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand status took 1 milliseconds Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand status took 1 milliseconds Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 15:56:49 volumio volumio[730]: info: Apr 23 15:56:49 volumio volumio[730]: ---------------------------- MPD announces state update: player Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::getState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand status Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand status took 2 milliseconds Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand status took 0 milliseconds Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseTrackInfo Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseTrackInfo Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseState Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::pushState Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1616,"duration":262,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"The Life","artist":"Sally Yeh - SACD Collection","album":"Sally Yeh - SACD Collection","uri":"NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf","trackType":"dsf"} Apr 23 15:56:49 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState stateService play Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus stop Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::pushState Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1616,"duration":262,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"The Life","artist":"Sally Yeh - SACD Collection","album":"Sally Yeh - SACD Collection","uri":"NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf","trackType":"dsf"} Apr 23 15:56:49 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState stateService play Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 23 15:56:49 volumio volumio[730]: info: Received an update from plugin. extracting info from payload Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: ------------------------------ 8ms Apr 23 15:56:49 volumio volumio[730]: info: ------------------------------ 10ms Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 23 15:56:49 volumio volumio[730]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 23 15:56:49 volumio volumio[730]: verbose: ControllerMpd::parseTrackInfo Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::pushState Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1616,"duration":262,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"The Life","artist":"Sally Yeh - SACD Collection","album":"Sally Yeh - SACD Collection","uri":"NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf","trackType":"dsf"} Apr 23 15:56:49 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState stateService play Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 23 15:56:49 volumio volumio[730]: info: Received an update from plugin. extracting info from payload Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: ControllerMpd::pushState Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1616,"duration":262,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"The Life","artist":"Sally Yeh - SACD Collection","album":"Sally Yeh - SACD Collection","uri":"NAS/CHNAOS/DSD/喜爱/叶倩文/叶倩文.2002 -《COLLECTION》SACD限量绝版 [ISO]/01 - The Life.dsf","trackType":"dsf"} Apr 23 15:56:49 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState stateService play Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 23 15:56:49 volumio volumio[730]: info: Received an update from plugin. extracting info from payload Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:56:49 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:49 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:56:49 volumio volumio[730]: info: ------------------------------ 17ms Apr 23 15:56:49 volumio volumio[730]: info: ------------------------------ 16ms Apr 23 15:56:50 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Atrium%20Musicae%20de%20Madrid%20%2F%20Gregorio%20Paniagua/b3cd651a-f9f0-4dda-bb04-8050b71667c6.jpg' Apr 23 15:56:52 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ayako%20Hosokawa/f46fe968-f5e2-4bd7-a642-abcaa7a5dd9d.jpg' Apr 23 15:56:52 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BEYOND/ed6dee18-161a-4c52-b3c2-285289a90ee1.jpg' Apr 23 15:56:52 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BLUE%20CHAMBER%20QUARTET/7f34e87f-8f6f-41a1-9f03-c22001eabe3d.jpg' Apr 23 15:56:53 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 23 15:56:53 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:56:54 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Babyface/3ca27f0d-e52b-448e-a111-7e8ac1aa33ee.jpg' Apr 23 15:57:01 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beoga/2dd5719d-eb38-4438-8c6d-fc1a3e8d952d.jpg' Apr 23 15:57:02 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Berliner%20Philharmoniker%20-%20Herbert%20von%20Karajan/b5ae17e7-33e5-4ced-8000-34e95f5dd2aa.jpg' Apr 23 15:57:07 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyonc%C3%A9/d3893497-aaad-4573-8233-c2f6c96635ac.jpg' Apr 23 15:57:07 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/9ece641a-e05b-4ad2-89db-e6d1069a2b34.jpg' Apr 23 15:57:09 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BiBi/adf502ec-2d9f-4c1c-ad00-ea601d54ad10.jpg' Apr 23 15:57:10 volumio volumio[730]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Blue%20Chamber%20Quartet/c957c174-3fe2-4c3f-b428-f24cdff394cb.jpg' Apr 23 15:57:42 volumio volumio[730]: info: VolumeController::SetAlsaVolume100 Apr 23 15:57:42 volumio volumio[730]: info: CoreStateMachine::pushState Apr 23 15:57:42 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 23 15:57:42 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 23 15:57:42 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 23 15:57:49 volumio volumio[730]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 15:57:49 volumio volumio[730]: Error: connect ETIMEDOUT 174.37.154.236:80 Apr 23 15:57:49 volumio volumio[730]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 23 15:57:49 volumio volumio[730]: errno: -110, Apr 23 15:57:49 volumio volumio[730]: code: 'ETIMEDOUT', Apr 23 15:57:49 volumio volumio[730]: syscall: 'connect', Apr 23 15:57:49 volumio volumio[730]: address: '174.37.154.236', Apr 23 15:57:49 volumio volumio[730]: port: 80 Apr 23 15:57:49 volumio volumio[730]: } Apr 23 15:57:49 volumio volumio[730]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 15:57:49 volumio sudo[1857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 15:56 Apr 23 15:57:49 volumio sudo[1857]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"