Jan 10 16:01:00 deeztunes volumio[10716]: info: Updating MyVolumio device info Jan 10 16:01:00 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:01:00 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:01:00 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:01:01 deeztunes volumio[10716]: info: Successfully Updated MyVolumio device Jan 10 16:01:01 deeztunes volumio[10716]: info: Bluetoothremote--- Checking for trusted devices to reconnect... Jan 10 16:01:01 deeztunes volumio[10716]: info: Bluetoothremote--- Device list cleared and placeholder written. Jan 10 16:01:01 deeztunes bluetoothd[993]: Adv Monitor app :1.50 disconnected from D-Bus Jan 10 16:01:01 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:01:01 deeztunes volumio[10716]: info: Bluetoothremote--- Device found: Press scan to detect BT device - xx Jan 10 16:01:01 deeztunes bluetoothd[993]: Adv Monitor app :1.51 disconnected from D-Bus Jan 10 16:01:06 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 16:01:06 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:01:06 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 10 16:01:06 deeztunes volumio-remote-updater[723]: Test mode disabled Jan 10 16:01:06 deeztunes volumio-remote-updater[723]: Alpha mode disabled Jan 10 16:01:06 deeztunes volumio-remote-updater[723]: Alpha legacy test mode disabled Jan 10 16:01:06 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 10 16:01:06 deeztunes volumio[10716]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 10 16:01:06 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 10 16:01:09 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 16:01:09 deeztunes volumio[10716]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jan 10 16:01:09 deeztunes volumio[10716]: info: CoreCommandRouter::volumioGetState Jan 10 16:01:09 deeztunes volumio[10716]: info: CorePlayQueue::getTrack 0 Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 16:01:14 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 16:01:16 deeztunes volumio[10716]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 10 16:01:16 deeztunes volumio[10716]: info: Completed starting MyVolumio Plugin Jan 10 16:01:16 deeztunes volumio[10716]: [Metrics] CommandRouter: 52s 284.98ms Jan 10 16:01:16 deeztunes volumio[10716]: info: CoreCommandRouter::volumiosetStartupVolume Jan 10 16:01:16 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:01:16 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:01:16 deeztunes volumio[10716]: info: CoreCommandRouter::Close All Modals sent Jan 10 16:01:16 deeztunes volumio[10716]: info: CoreCommandRouter::Close All Modals sent Jan 10 16:01:16 deeztunes volumio[10716]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jan 10 16:01:16 deeztunes volumio[10716]: ALSA lib /home/pi/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo Jan 10 16:01:16 deeztunes volumio[10716]: aplay: main:831: audio open error: No such file or directory Jan 10 16:01:17 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 10 16:01:17 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 16:01:17 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 10 16:01:19 deeztunes systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jan 10 16:01:23 deeztunes volumio[10716]: info: BOOT COMPLETED Jan 10 16:01:32 deeztunes volumio[10716]: info: CALLMETHOD: system_hardware Bluetoothremote saveBT [object Object] Jan 10 16:01:32 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: Bluetoothremote , saveBT Jan 10 16:01:32 deeztunes volumio[10716]: info: Bluetoothremote--- Attempting to stop Bluetooth scan... Jan 10 16:01:32 deeztunes volumio[10716]: info: Bluetoothremote--- No device selected! Jan 10 16:01:32 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 16:01:32 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 10 16:01:32 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:01:32 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/peq' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/filter-sources/' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/target-curves/' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/tools/' Jan 10 16:01:33 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/peq' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/filter-sources/' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/target-curves/' Jan 10 16:01:33 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/tools/' Jan 10 16:02:06 deeztunes volumio[10716]: info: Enabling plugin now_playing Jan 10 16:02:06 deeztunes volumio[10716]: info: Loading plugin "now_playing"... Jan 10 16:02:06 deeztunes volumio[10716]: error: !!!! WARNING !!!! Jan 10 16:02:06 deeztunes volumio[10716]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Jan 10 16:02:06 deeztunes volumio[10716]: Require stack: Jan 10 16:02:06 deeztunes volumio[10716]: - /data/plugins/user_interface/now_playing/dist/index.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/app/pluginmanager.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/app/index.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/index.js Jan 10 16:02:06 deeztunes volumio[10716]: error: Stack trace: Error: Cannot find module 'geo-tz' Jan 10 16:02:06 deeztunes volumio[10716]: Require stack: Jan 10 16:02:06 deeztunes volumio[10716]: - /data/plugins/user_interface/now_playing/dist/index.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/app/pluginmanager.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/app/index.js Jan 10 16:02:06 deeztunes volumio[10716]: - /volumio/index.js Jan 10 16:02:06 deeztunes volumio[10716]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Jan 10 16:02:06 deeztunes volumio[10716]: at Module._load (node:internal/modules/cjs/loader:901:27) Jan 10 16:02:06 deeztunes volumio[10716]: at Module.require (node:internal/modules/cjs/loader:1115:19) Jan 10 16:02:06 deeztunes volumio[10716]: at require (node:internal/modules/helpers:130:18) Jan 10 16:02:06 deeztunes volumio[10716]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jan 10 16:02:06 deeztunes volumio[10716]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Jan 10 16:02:06 deeztunes volumio[10716]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Jan 10 16:02:06 deeztunes volumio[10716]: at Module.load (node:internal/modules/cjs/loader:1091:32) Jan 10 16:02:06 deeztunes volumio[10716]: at Module._load (node:internal/modules/cjs/loader:938:12) Jan 10 16:02:06 deeztunes volumio[10716]: at Module.require (node:internal/modules/cjs/loader:1115:19) Jan 10 16:02:06 deeztunes volumio[10716]: at require (node:internal/modules/helpers:130:18) Jan 10 16:02:06 deeztunes volumio[10716]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jan 10 16:02:06 deeztunes volumio[10716]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jan 10 16:02:06 deeztunes volumio[10716]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 10 16:02:06 deeztunes volumio[10716]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 10 16:02:06 deeztunes volumio[10716]: error: !!!! WARNING !!!! Jan 10 16:02:06 deeztunes volumio[10716]: info: Done. Jan 10 16:02:06 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:02:06 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/peq' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/filter-sources/' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/target-curves/' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/tools/' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/peq' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/filter-sources/' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/target-curves/' Jan 10 16:02:06 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/tools/' Jan 10 16:02:14 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:02:20 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 16:02:20 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 10 16:02:20 deeztunes volumio[10716]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 16:02:20 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Jan 10 16:02:20 deeztunes volumio[10716]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/peq' Jan 10 16:02:20 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/filter-sources/' Jan 10 16:02:20 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/target-curves/' Jan 10 16:02:20 deeztunes volumio[10716]: error: FusionDsp - Could not read file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/tools/' Jan 10 16:02:34 deeztunes volumio[10716]: info: Enabling plugin peppymeterbasic Jan 10 16:02:34 deeztunes volumio[10716]: info: Loading plugin "peppymeterbasic"... Jan 10 16:02:35 deeztunes volumio[10716]: info: Preparing to generate the ALSA configuration file Jan 10 16:02:35 deeztunes volumio[10716]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 10 16:02:35 deeztunes volumio[10716]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Jan 10 16:02:35 deeztunes volumio[10716]: info: Reading ALSA contributions from plugins. Jan 10 16:02:35 deeztunes volumio[10716]: info: Asound.conf file unchanged, so no further update is needed Jan 10 16:02:35 deeztunes volumio[10716]: info: Output device has changed, restarting MPD Jan 10 16:02:35 deeztunes volumio[10716]: info: Output device has changed, restarting Shairport Sync Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:02:35 deeztunes sudo[12010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 16:02:35 deeztunes sudo[12010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes sudo[12010]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:35 deeztunes sudo[12012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 16:02:35 deeztunes sudo[12012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes volumio[10716]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 16:02:35 deeztunes volumio[10716]: info: PLUGIN START: peppymeterbasic Jan 10 16:02:35 deeztunes systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 10 16:02:35 deeztunes volumio[10716]: info: Preparing to generate the ALSA configuration file Jan 10 16:02:35 deeztunes sudo[12020]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Jan 10 16:02:35 deeztunes sudo[12020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes volumio[10716]: info: Error: TypeError: Cannot read properties of null (reading 'printToastMessage') Jan 10 16:02:35 deeztunes volumio[10716]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 10 16:02:35 deeztunes systemd[1]: mpd.service: Deactivated successfully. Jan 10 16:02:35 deeztunes systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 16:02:35 deeztunes systemd[1]: mpd.service: Consumed 3.589s CPU time. Jan 10 16:02:35 deeztunes systemd[1]: mpd.socket: Deactivated successfully. Jan 10 16:02:35 deeztunes systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 16:02:35 deeztunes systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 16:02:35 deeztunes volumio[10716]: info: MPD Permissions set Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::volumioGetState Jan 10 16:02:35 deeztunes volumio[10716]: info: CorePlayQueue::getTrack 0 Jan 10 16:02:35 deeztunes volumio[10716]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Jan 10 16:02:35 deeztunes volumio[10716]: info: Reading ALSA contributions from plugins. Jan 10 16:02:35 deeztunes sudo[12020]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:35 deeztunes volumio[10716]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 16:02:35 deeztunes (udev-worker)[12027]: controlC7: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 7' failed with exit code 99. Jan 10 16:02:35 deeztunes systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 16:02:35 deeztunes volumio[10716]: info: snd_dummy loaded Jan 10 16:02:35 deeztunes volumio[10716]: info: Starting Shairport Sync Jan 10 16:02:35 deeztunes sudo[12036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 16:02:35 deeztunes sudo[12036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes volumio[10716]: info: Asound.conf file unchanged, so no further update is needed Jan 10 16:02:35 deeztunes volumio[10716]: info: Output device has changed, restarting MPD Jan 10 16:02:35 deeztunes systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 16:02:35 deeztunes systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 16:02:35 deeztunes systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 16:02:35 deeztunes systemd[1]: shairport-sync.service: Consumed 2.235s CPU time. Jan 10 16:02:35 deeztunes volumio[10716]: info: Output device has changed, restarting Shairport Sync Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:02:35 deeztunes sudo[12040]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 16:02:35 deeztunes sudo[12040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes sudo[12040]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:35 deeztunes sudo[12042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 16:02:35 deeztunes sudo[12042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:35 deeztunes volumio[10716]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 16:02:35 deeztunes systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 16:02:35 deeztunes systemd[1]: mpd.service: Deactivated successfully. Jan 10 16:02:35 deeztunes volumio[10716]: info: MPD Permissions set Jan 10 16:02:35 deeztunes systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 16:02:35 deeztunes sudo[12036]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes systemd[1]: mpd.socket: Deactivated successfully. Jan 10 16:02:35 deeztunes systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 16:02:35 deeztunes systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 16:02:35 deeztunes systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 16:02:35 deeztunes systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:02:35 deeztunes volumio[10716]: info: Shairport-Sync Started Jan 10 16:02:35 deeztunes volumio[10716]: error: [ytcr] Error connecting MPD: Jan 10 16:02:35 deeztunes volumio[10716]: (Error) read ECONNRESET Jan 10 16:02:35 deeztunes volumio[10716]: Error: read ECONNRESET Jan 10 16:02:35 deeztunes volumio[10716]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) Jan 10 16:02:35 deeztunes volumio[10716]: Retrying in 5 seconds... Jan 10 16:02:35 deeztunes volumio[10716]: info: Starting Shairport Sync Jan 10 16:02:35 deeztunes sudo[12076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 16:02:35 deeztunes sudo[12076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 16:02:36 deeztunes systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 16:02:36 deeztunes systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 16:02:36 deeztunes systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 16:02:36 deeztunes systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 16:02:36 deeztunes sudo[12072]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 10 16:02:36 deeztunes sudo[12072]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 10 16:02:36 deeztunes sudo[12072]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:36 deeztunes sudo[12076]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:36 deeztunes volumio[10716]: info: Shairport-Sync Started Jan 10 16:02:39 deeztunes mpd[12080]: 2026-01-10T16:02:38 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 10 16:02:39 deeztunes systemd[1]: Started mpd.service - Music Player Daemon. Jan 10 16:02:39 deeztunes sudo[12012]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:39 deeztunes sudo[12042]: pam_unix(sudo:session): session closed for user root Jan 10 16:02:39 deeztunes volumio[10716]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 16:02:39 deeztunes volumio[10716]: TypeError: Cannot read properties of null (reading 'printToastMessage') Jan 10 16:02:39 deeztunes volumio[10716]: at /volumio/app/index.js:1214:32 Jan 10 16:02:39 deeztunes volumio[10716]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jan 10 16:02:39 deeztunes volumio[10716]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jan 10 16:02:39 deeztunes volumio[10716]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1212:13) Jan 10 16:02:39 deeztunes volumio[10716]: at /volumio/app/plugins/music_service/mpd/index.js:798:30 Jan 10 16:02:39 deeztunes volumio[10716]: at /volumio/app/plugins/music_service/mpd/index.js:945:9 Jan 10 16:02:39 deeztunes volumio[10716]: at ChildProcess.exithandler (node:child_process:413:7) Jan 10 16:02:39 deeztunes volumio[10716]: at ChildProcess.emit (node:events:514:28) Jan 10 16:02:39 deeztunes volumio[10716]: at maybeClose (node:internal/child_process:1105:16) Jan 10 16:02:39 deeztunes volumio[10716]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Jan 10 16:02:39 deeztunes volumio[10716]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 16:02:39 deeztunes sudo[12125]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-10 16:01' Jan 10 16:02:39 deeztunes sudo[12125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"