Feb 08 18:08:02 volumio kernel: usb 1-1.5: new high-speed USB device number 5 using ehci-pci Feb 08 18:08:02 volumio kernel: usb 1-1.5: New USB device found, idVendor=152a, idProduct=8829, bcdDevice= 3.12 Feb 08 18:08:02 volumio kernel: usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 08 18:08:02 volumio kernel: usb 1-1.5: Product: MUSICIAN USB HiRes Audio Feb 08 18:08:02 volumio kernel: usb 1-1.5: Manufacturer: MUSICIAN Feb 08 18:08:02 volumio kernel: usb 1-1.5: Warning! Unlikely big volume range (=512), cval->res is probably wrong. Feb 08 18:08:02 volumio kernel: usb 1-1.5: [10] FU [PCM Playback Volume] ch = 2, val = -16384/0/32 Feb 08 18:08:02 volumio volumio[1294]: info: Feb 08 18:08:02 volumio volumio[1294]: ---------------------------- USB Audio Device Attached Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::Close All Modals sent Feb 08 18:08:02 volumio volumio[1294]: info: Preparing to save Alsa Options, stopping services first Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioGetState Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioPause Feb 08 18:08:02 volumio volumio[1294]: info: CoreStateMachine::pause Feb 08 18:08:02 volumio volumio[1294]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"MUSICIAN USB HiRes Audio","alsacard":"Audio"},"i2s":false} Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 18:08:02 volumio volumio[1294]: info: Setting mixer PCM for card MUSICIAN USB HiRes Audio Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 08 18:08:02 volumio volumio[1294]: info: Updating Volume Controller Parameters: Device: 5 Name: MUSICIAN USB HiRes Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 08 18:08:02 volumio volumio[1294]: info: Disabling external Volume Control Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 18:08:02 volumio volumio[1294]: info: Preparing to generate the ALSA configuration file Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 08 18:08:02 volumio volumio[1294]: info: Asound.conf file unchanged, so no further update is needed Feb 08 18:08:02 volumio volumio[1294]: info: Output device has changed, restarting MPD Feb 08 18:08:02 volumio sudo[103079]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 18:08:02 volumio sudo[103079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 18:08:02 volumio sudo[103079]: pam_unix(sudo:session): session closed for user root Feb 08 18:08:02 volumio volumio[1294]: info: Output device has changed, restarting Shairport Sync Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 18:08:02 volumio sudo[103082]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 18:08:02 volumio sudo[103082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 18:08:02 volumio volumio[1294]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 18:08:02 volumio volumio[1294]: info: VolumeController:: Volume=41 Mute =false Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioGetState Feb 08 18:08:02 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 18:08:02 volumio volumio[1294]: info: CoreStateMachine::pushState Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::servicePushState Feb 08 18:08:02 volumio volumio[1294]: info: CoreStateMachine::pushState Feb 08 18:08:02 volumio volumio[1294]: info: CoreCommandRouter::volumioPushState Feb 08 18:08:02 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 18:08:02 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 18:08:02 volumio systemd[1]: mpd.service: Consumed 16.877s CPU time. Feb 08 18:08:02 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 18:08:02 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 18:08:02 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 18:08:02 volumio volumio[1294]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 18:08:02 volumio volumio[1294]: MPDError: Not connected Feb 08 18:08:02 volumio volumio[1294]: at MPDClient.send (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:101:13) Feb 08 18:08:02 volumio volumio[1294]: at MPDClient.sendCommand (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:65:10) Feb 08 18:08:02 volumio volumio[1294]: at Object.get (/data/plugins/music_service/ytcr/node_modules/mpd-api/lib/api/index.js:60:16) Feb 08 18:08:02 volumio volumio[1294]: at MPDPlayer.getVolumioState (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:297:100) Feb 08 18:08:02 volumio volumio[1294]: at ControllerYTCR.pushState (/data/plugins/music_service/ytcr/dist/index.js:566:104) Feb 08 18:08:02 volumio volumio[1294]: at /data/plugins/music_service/ytcr/dist/index.js:310:28 Feb 08 18:08:02 volumio volumio[1294]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Feb 08 18:08:02 volumio volumio[1294]: code: 'ENOTCONNECTED' Feb 08 18:08:02 volumio volumio[1294]: } Feb 08 18:08:02 volumio volumio[1294]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 18:08:02 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 18:08:02 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 18:08:03 volumio sudo[103103]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 18:08:03 volumio sudo[103103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 18:08:03 volumio sudo[103103]: pam_unix(sudo:session): session closed for user root Feb 08 18:08:03 volumio sudo[103108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 18:07' Feb 08 18:08:03 volumio sudo[103108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"