-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2025-07-09 08:58:44 CST. -- Jul 09 08:57:31 volumio ntpd[660]: receive: Unexpected origin timestamp 0xec00dd78.383d9dd7 does not match aorg 0000000000.00000000 from server@114.34.171.136 xmt 0xec183cfb.6b27c645 Jul 09 08:57:31 volumio ntpd[660]: receive: Unexpected origin timestamp 0xec00dd78.38416873 does not match aorg 0000000000.00000000 from server@123.204.232.128 xmt 0xec183cfb.6b825295 Jul 09 08:57:31 volumio systemd[1]: Starting Daily apt download activities... Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 09 08:57:31 volumio ntpd[660]: receive: Unexpected origin timestamp 0xec00dd78.38325971 does not match aorg 0000000000.00000000 from server@103.186.118.212 xmt 0xec183cfb.771c14a2 Jul 09 08:57:31 volumio volumio[831]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 09 08:57:31 volumio volumio[831]: info: Received Get System Version Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 08:57:31 volumio volumio[831]: info: Received Get System Info Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 08:57:31 volumio volumio[831]: info: Discovery: Getting this device information Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 09 08:57:31 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 08:57:32 volumio volumio[831]: info: Discovery: A device disappeared from network Jul 09 08:57:32 volumio volumio[831]: info: Discovery: Device volumio disappeared from network Jul 09 08:57:32 volumio systemd[1]: apt-daily.service: Succeeded. Jul 09 08:57:32 volumio systemd[1]: Started Daily apt download activities. Jul 09 08:57:32 volumio volumio[831]: info: Discovery: adding 2a599974-f9fa-4ad8-8b0a-611dcc7ead94 Jul 09 08:57:32 volumio volumio[831]: info: Discovery: Found device Volumio Jul 09 08:57:32 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 09 08:57:32 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:32 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jul 09 08:57:33 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 09 08:57:33 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jul 09 08:57:37 volumio kernel: usb 1-1.4: new high-speed USB device number 5 using dwc_otg Jul 09 08:57:37 volumio kernel: usb 1-1.4: New USB device found, idVendor=20b1, idProduct=2005, bcdDevice= 2.01 Jul 09 08:57:37 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 09 08:57:37 volumio kernel: usb 1-1.4: Product: USB Audio 2.0 Jul 09 08:57:37 volumio kernel: usb 1-1.4: Manufacturer: denafrips Jul 09 08:57:37 volumio kernel: usb 1-1.4: 1:3 : unsupported format bits 0x100000000 Jul 09 08:57:37 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jul 09 08:57:37 volumio volumio[831]: info: Jul 09 08:57:37 volumio volumio[831]: ---------------------------- USB Audio Device Attached Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::Close All Modals sent Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 08:57:37 volumio volumio[831]: info: Setting mixer USB Audio 2.0 for card USB Audio 2.0 Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 09 08:57:37 volumio volumio[831]: info: Updating Volume Controller Parameters: Device: 5 Name: USB Audio 2.0 Mixer: USB Audio 2.0 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 09 08:57:37 volumio volumio[831]: info: Disabling external Volume Control Jul 09 08:57:37 volumio volumio[831]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 08:57:37 volumio volumio[831]: info: Preparing to generate the ALSA configuration file Jul 09 08:57:37 volumio volumio[831]: info: Asound.conf file unchanged, so no further update is needed Jul 09 08:57:37 volumio volumio[831]: info: Output device has changed, restarting MPD Jul 09 08:57:37 volumio sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 08:57:37 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 08:57:37 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root Jul 09 08:57:38 volumio volumio[831]: info: Output device has changed, restarting Shairport Sync Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 08:57:38 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 08:57:38 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 08:57:38 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 08:57:38 volumio volumio[831]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 08:57:38 volumio systemd[1]: mpd.service: Succeeded. Jul 09 08:57:38 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 08:57:38 volumio volumio[831]: info: MPD Permissions set Jul 09 08:57:38 volumio volumio[831]: info: VolumeController:: Volume=100 Mute =false Jul 09 08:57:38 volumio systemd[1]: Starting Music Player Daemon... Jul 09 08:57:38 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:57:38 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 08:57:38 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 09 08:57:38 volumio volumio[831]: info: Starting Shairport Sync Jul 09 08:57:38 volumio sudo[1363]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 08:57:38 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 08:57:38 volumio sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 08:57:38 volumio sudo[1363]: pam_unix(sudo:session): session closed for user root Jul 09 08:57:38 volumio sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 08:57:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 08:57:38 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 08:57:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 08:57:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 08:57:38 volumio sudo[1369]: pam_unix(sudo:session): session closed for user root Jul 09 08:57:38 volumio volumio[831]: info: Shairport-Sync Started Jul 09 08:57:39 volumio mpd[1372]: Jul 09 08:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 08:57:39 volumio systemd[1]: Started Music Player Daemon. Jul 09 08:57:39 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root Jul 09 08:57:39 volumio volumio[831]: error: updateQueue error: null Jul 09 08:57:41 volumio volumio[831]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 09 08:57:41 volumio volumio[831]: info: CoreStateMachine::getcurrentVolume Jul 09 08:57:41 volumio volumio[831]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 08:57:41 volumio volumio[831]: info: VolumeController:: Volume=100 Mute =false Jul 09 08:57:41 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:57:41 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:41 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 08:57:41 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:57:41 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Jul 09 08:57:41 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Jul 09 08:57:41 volumio volumio[831]: info: CoreCommandRouter::volumioRetrievevolume Jul 09 08:57:42 volumio volumio[831]: info: VolumeController:: Volume=100 Mute =false Jul 09 08:57:42 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:57:42 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:42 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 08:57:42 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::volumioPlay Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::play index undefined Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::startPlaybackTimer Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::clearAddPlayTracks USB/Backup_SG2T/音樂倉庫/器樂演奏/韓庭貴 - 書韻(山東箏曲)/01. 高山流水.ape Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand stop took 1 milliseconds Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand clear Jul 09 08:57:44 volumio volumio[831]: info: Jul 09 08:57:44 volumio volumio[831]: ---------------------------- MPD announces system playlist update Jul 09 08:57:44 volumio volumio[831]: info: Ignoring MPD Status Update Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand clear took 1 milliseconds Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand add "USB/Backup_SG2T/音樂倉庫/器樂演奏/韓庭貴 - 書韻(山東箏曲)/01. 高山流水.ape" Jul 09 08:57:44 volumio volumio[831]: error: updateQueue error: null Jul 09 08:57:44 volumio volumio[831]: info: Jul 09 08:57:44 volumio volumio[831]: ---------------------------- MPD announces system playlist update Jul 09 08:57:44 volumio volumio[831]: info: Ignoring MPD Status Update Jul 09 08:57:44 volumio volumio[831]: info: ------------------------------ 3ms Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand add "USB/Backup_SG2T/音樂倉庫/器樂演奏/韓庭貴 - 書韻(山東箏曲)/01. 高山流水.ape" took 2 milliseconds Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand play Jul 09 08:57:44 volumio volumio[831]: info: ------------------------------ 3ms Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand play took 3 milliseconds Jul 09 08:57:44 volumio volumio[831]: info: Jul 09 08:57:44 volumio volumio[831]: ---------------------------- MPD announces state update: player Jul 09 08:57:44 volumio volumio[831]: info: ControllerMpd::getState Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Jul 09 08:57:44 volumio volumio[831]: info: Jul 09 08:57:44 volumio volumio[831]: ---------------------------- MPD announces state update: player Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand status took 38 milliseconds Jul 09 08:57:44 volumio volumio[831]: info: ControllerMpd::getState Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::parseState Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::parseState Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 09 08:57:44 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Jul 09 08:57:44 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Jul 09 08:57:44 volumio volumio[831]: info: ControllerMpd::pushState Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"高山流水","artist":"韓庭貴","album":"書韻(山東箏曲)","uri":"USB/Backup_SG2T/音樂倉庫/器樂演奏/韓庭貴 - 書韻(山東箏曲)/01. 高山流水.ape","trackType":"ape"} Jul 09 08:57:44 volumio volumio[831]: verbose: CURRENT POSITION 0 Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus stop Jul 09 08:57:44 volumio volumio[831]: info: ControllerMpd::pushState Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":326,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"高山流水","artist":"韓庭貴","album":"書韻(山東箏曲)","uri":"USB/Backup_SG2T/音樂倉庫/器樂演奏/韓庭貴 - 書韻(山東箏曲)/01. 高山流水.ape","trackType":"ape"} Jul 09 08:57:44 volumio volumio[831]: verbose: CURRENT POSITION 0 Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Jul 09 08:57:44 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:57:44 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:57:44 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:57:44 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:57:44 volumio volumio[831]: info: ------------------------------ 66ms Jul 09 08:57:44 volumio volumio[831]: info: ------------------------------ 39ms Jul 09 08:58:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetQueue Jul 09 08:58:01 volumio volumio[831]: info: CoreStateMachine::getQueue Jul 09 08:58:01 volumio volumio[831]: info: CorePlayQueue::getQueue Jul 09 08:58:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 08:58:37 volumio volumio[831]: info: CURURI: music-library/USB/Backup_SG2T/音樂倉庫/測試碟 Jul 09 08:58:37 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:37 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:37 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:37 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:37 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:37 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:37 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:37 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:37 volumio volumio[831]: info: Preload queue cleared Jul 09 08:58:37 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:37 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:37 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:37 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:37 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:37 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:37 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:37 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:38 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:38 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:38 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:38 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:38 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:38 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:38 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:38 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:38 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:38 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:38 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:38 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:38 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:38 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:38 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:38 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:38 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:38 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:38 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:38 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:38 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:38 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:38 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:38 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:38 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:38 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:38 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:38 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:38 volumio volumio[831]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jul 09 08:58:38 volumio volumio[831]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jul 09 08:58:38 volumio volumio[831]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Jul 09 08:58:38 volumio volumio[831]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Jul 09 08:58:38 volumio volumio[831]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Jul 09 08:58:38 volumio volumio[831]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Jul 09 08:58:38 volumio volumio[831]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 08:58:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 09 08:58:43 volumio volumio[831]: info: Preload queue cleared Jul 09 08:58:43 volumio volumio[831]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::ClearQueue Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::stop Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::stPlaybackTimer Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::pushState Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:58:43 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 08:58:43 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::serviceStop Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 09 08:58:43 volumio volumio[831]: info: CoreCommandRouter::serviceStop Jul 09 08:58:43 volumio volumio[831]: info: ControllerMpd::stop Jul 09 08:58:43 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::clearPlayQueue Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::saveQueue Jul 09 08:58:43 volumio volumio[831]: info: CoreCommandRouter::volumioPushQueue Jul 09 08:58:43 volumio volumio[831]: info: CoreStateMachine::addQueueItems Jul 09 08:58:43 volumio volumio[831]: info: CorePlayQueue::addQueueItems Jul 09 08:58:43 volumio volumio[831]: info: Preload queue cleared Jul 09 08:58:43 volumio volumio[831]: info: Adding Item to queue: music-library/USB/Backup_SG2T/音樂倉庫/測試碟/2005 香港高級視聽展紀念 SACD《2005 原音精選》 Jul 09 08:58:43 volumio volumio[831]: info: Exploding uri music-library/USB/Backup_SG2T/音樂倉庫/測試碟/2005 香港高級視聽展紀念 SACD《2005 原音精選》 in service mpd Jul 09 08:58:43 volumio volumio[831]: info: Jul 09 08:58:43 volumio volumio[831]: ---------------------------- MPD announces state update: player Jul 09 08:58:43 volumio volumio[831]: info: ALBUMART /albumart?cacheid=125&web=/The%20Perfect%20Sound%202005/extralarge&path=%2Fmnt%2FUSB%2FBackup_SG2T%2F%E9%9F%B3%E6%A8%82%E5%80%89%E5%BA%AB%2F%E6%B8%AC%E8%A9%A6%E7%A2%9F%2F2005%20%E9%A6%99%E6%B8%AF%E9%AB%98%E7%B4%9A%E8%A6%96%E8%81%BD%E5%B1%95%E7%B4%80%E5%BF%B5%20SACD%E3%80%8A2005%20%E5%8E%9F%E9%9F%B3%E7%B2%BE%E9%81%B8%E3%80%8B%2FCDImage.ape&metadata=false Jul 09 08:58:43 volumio volumio[831]: info: URI /mnt/USB/Backup_SG2T/音樂倉庫/測試碟/2005 香港高級視聽展紀念 SACD《2005 原音精選》/CDImage.ape Jul 09 08:58:43 volumio volumio[831]: info: ALBUMART /albumart?cacheid=125&web=You%20don't%20know%20me/The%20Perfect%20Sound%202005/extralarge&path=%2Fmnt%2FUSB%2FBackup_SG2T%2F%E9%9F%B3%E6%A8%82%E5%80%89%E5%BA%AB%2F%E6%B8%AC%E8%A9%A6%E7%A2%9F%2F2005%20%E9%A6%99%E6%B8%AF%E9%AB%98%E7%B4%9A%E8%A6%96%E8%81%BD%E5%B1%95%E7%B4%80%E5%BF%B5%20SACD%E3%80%8A2005%20%E5%8E%9F%E9%9F%B3%E7%B2%BE%E9%81%B8%E3%80%8B%2FCDImage.cue&metadata=false Jul 09 08:58:43 volumio volumio[831]: info: URI /mnt/USB/Backup_SG2T/音樂倉庫/測試碟/2005 香港高級視聽展紀念 SACD《2005 原音精選》/CDImage.cue Jul 09 08:58:43 volumio volumio[831]: info: ALBUMART /albumart?cacheid=125&web=Carmen%20Habanera%20Fantasia/The%20Perfect%20Sound%202005/extralarge&path=%2Fmnt%2FUSB%2FBackup_SG2T%2F%E9%9F%B3%E6%A8%82%E5%80%89%E5%BA%AB%2F%E6%B8%AC%E8%A9%A6%E7%A2%9F%2F2005%20%E9%A6%99%E6%B8%AF%E9%AB%98%E7%B4%9A%E8%A6%96%E8%81%BD%E5%B1%95%E7%B4%80%E5%BF%B5%20SACD%E3%80%8A2005%20%E5%8E%9F%E9%9F%B3%E7%B2%BE%E9%81%B8%E3%80%8B%2FCDImage.cue&metadata=false Jul 09 08:58:43 volumio volumio[831]: info: URI /mnt/USB/Backup_SG2T/音樂倉庫/測試碟/2005 香港高級視聽展紀念 SACD《2005 原音精選》/CDImage.cue Jul 09 08:58:43 volumio volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 08:58:43 volumio volumio[831]: Error: Unable to resolve or reject the same promise twice Jul 09 08:58:43 volumio volumio[831]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 09 08:58:43 volumio volumio[831]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jul 09 08:58:43 volumio volumio[831]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 09 08:58:43 volumio volumio[831]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 09 08:58:43 volumio volumio[831]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 09 08:58:43 volumio volumio[831]: at Socket.emit (events.js:315:20) Jul 09 08:58:43 volumio volumio[831]: at addChunk (internal/streams/readable.js:309:12) Jul 09 08:58:43 volumio volumio[831]: at readableAddChunk (internal/streams/readable.js:280:11) Jul 09 08:58:43 volumio volumio[831]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jul 09 08:58:43 volumio volumio[831]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 09 08:58:43 volumio volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 08:58:44 volumio sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 08:57 Jul 09 08:58:44 volumio sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"