Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:00 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:00 volumio1 volumio[1283]: 1+18 records in Dec 17 22:14:00 volumio1 volumio[1283]: 1+18 records out Dec 17 22:14:00 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000519889 s, 254 MB/s Dec 17 22:14:00 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:00 volumio1 volumio[1283]: 217+30 records in Dec 17 22:14:00 volumio1 volumio[1283]: 217+30 records out Dec 17 22:14:00 volumio1 volumio[1283]: 7231744 bytes (7.2 MB, 6.9 MiB) copied, 0.0439274 s, 165 MB/s Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:01 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:01 volumio1 volumio[1283]: 1+18 records in Dec 17 22:14:01 volumio1 volumio[1283]: 1+18 records out Dec 17 22:14:01 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000529926 s, 250 MB/s Dec 17 22:14:01 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:01 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:01 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:01 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000534611 s, 247 MB/s Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:02 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:02 volumio1 volumio[1283]: 2+17 records in Dec 17 22:14:02 volumio1 volumio[1283]: 2+17 records out Dec 17 22:14:02 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000514575 s, 257 MB/s Dec 17 22:14:02 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:02 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:02 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:02 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000520741 s, 254 MB/s Dec 17 22:14:02 volumio1 G20[6515]: 2025-12-17 22:14:02 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:03 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:03 volumio1 volumio[1283]: 1+18 records in Dec 17 22:14:03 volumio1 volumio[1283]: 1+18 records out Dec 17 22:14:03 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000598463 s, 221 MB/s Dec 17 22:14:03 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:03 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:03 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:03 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000852205 s, 155 MB/s Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:04 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:04 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:04 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:04 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000728408 s, 182 MB/s Dec 17 22:14:04 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:04 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:04 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:04 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000522315 s, 253 MB/s Dec 17 22:14:05 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:14:05 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 17 22:14:05 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:05 volumio1 G20[6515]: 2025-12-17 22:14:05 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:05 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:05 volumio1 volumio[1283]: 1+18 records in Dec 17 22:14:05 volumio1 volumio[1283]: 1+18 records out Dec 17 22:14:05 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000541056 s, 244 MB/s Dec 17 22:14:05 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:05 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:05 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:05 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000732241 s, 181 MB/s Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:06 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 17 22:14:07 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:07 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:07 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:07 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000534352 s, 248 MB/s Dec 17 22:14:07 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:07 volumio1 volumio[1283]: 1+19 records in Dec 17 22:14:07 volumio1 volumio[1283]: 1+19 records out Dec 17 22:14:07 volumio1 volumio[1283]: 132288 bytes (132 kB, 129 KiB) copied, 0.000532852 s, 248 MB/s Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Stopping clipped samples monitor Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Stopping FusionDsp service Dec 17 22:14:07 volumio1 volumio[1283]: info: camilladsp service terminated, instance 4 Dec 17 22:14:07 volumio1 volumio[1283]: info: Disabling plugin fusiondsp Dec 17 22:14:07 volumio1 volumio[1283]: info: Preparing to generate the ALSA configuration file Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::pause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::servicePause Dec 17 22:14:07 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::servicePause Dec 17 22:14:07 volumio1 volumio[1283]: info: ControllerMpd::pause Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand pause Dec 17 22:14:07 volumio1 volumio[1283]: info: Dec 17 22:14:07 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:07 volumio1 sudo[26781]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 17 22:14:07 volumio1 volumio[1283]: info: sendMpdCommand pause took 3 milliseconds Dec 17 22:14:07 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:07 volumio1 volumio[1283]: info: Dec 17 22:14:07 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:07 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:07 volumio1 volumio[1283]: info: sendMpdCommand status took 2 milliseconds Dec 17 22:14:07 volumio1 sudo[26781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:07 volumio1 volumio[1283]: info: sendMpdCommand status took 1 milliseconds Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:07 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 17 22:14:07 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:07 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:07 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:07 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":34456,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"698 Kbps","isStreaming":false,"title":"Plus Profond","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/04. Plus Profond.flac","trackType":"flac"} Dec 17 22:14:07 volumio1 volumio[1283]: verbose: CURRENT POSITION 3 Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService pause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:07 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:07 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":34456,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"698 Kbps","isStreaming":false,"title":"Plus Profond","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/04. Plus Profond.flac","trackType":"flac"} Dec 17 22:14:07 volumio1 volumio[1283]: verbose: CURRENT POSITION 3 Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService pause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:07 volumio1 volumio[1283]: info: ------------------------------ 19ms Dec 17 22:14:07 volumio1 volumio[1283]: info: ------------------------------ 18ms Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:07 volumio1 systemd[1]: Stopping fusiondsp.service - FusionDsp Daemon... Dec 17 22:14:07 volumio1 volumio[1283]: info: Asound.conf file written Dec 17 22:14:07 volumio1 volumio[23035]: ======== Running on http://0.0.0.0:5011 ======== Dec 17 22:14:07 volumio1 volumio[23035]: (Press CTRL+C to quit) Dec 17 22:14:07 volumio1 sudo[26785]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 17 22:14:07 volumio1 sudo[26785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:07 volumio1 sudo[26785]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:07 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 17 22:14:07 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 17 22:14:07 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:14:07 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0099" "" "" Dec 17 22:14:07 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:14:07 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:14:07 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:14:07 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3086" "" "" Dec 17 22:14:07 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:14:07 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:14:07 volumio1 volumio[1283]: info: Output device has changed, restarting MPD Dec 17 22:14:07 volumio1 volumio[1283]: info: Output device has changed, restarting Shairport Sync Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:07 volumio1 sudo[26791]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 22:14:07 volumio1 sudo[26791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:07 volumio1 sudo[26791]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:07 volumio1 sudo[26794]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 22:14:07 volumio1 sudo[26794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:07 volumio1 volumio[1283]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 22:14:07 volumio1 volumio[1283]: info: Done. Dec 17 22:14:07 volumio1 volumio[1283]: info: MPD Permissions set Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:07 volumio1 systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 17 22:14:07 volumio1 volumio[1283]: info: Starting Shairport Sync Dec 17 22:14:07 volumio1 systemd[1]: fusiondsp.service: Deactivated successfully. Dec 17 22:14:07 volumio1 systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon. Dec 17 22:14:07 volumio1 systemd[1]: fusiondsp.service: Consumed 2.171s CPU time. Dec 17 22:14:07 volumio1 sudo[26806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 22:14:07 volumio1 sudo[26806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:07 volumio1 sudo[26781]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:07 volumio1 volumio[1283]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 17 22:14:07 volumio1 volumio[1283]: info: Removing fusiondspeq DSP Signal Path Element Dec 17 22:14:07 volumio1 systemd[1]: mpd.service: Deactivated successfully. Dec 17 22:14:07 volumio1 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 17 22:14:07 volumio1 systemd[1]: mpd.service: Consumed 3.679s CPU time. Dec 17 22:14:07 volumio1 systemd[1]: mpd.socket: Deactivated successfully. Dec 17 22:14:07 volumio1 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 17 22:14:07 volumio1 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 17 22:14:08 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:08 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:08 volumio1 volumio[1283]: 0 bytes copied, 0.000115648 s, 0.0 kB/s Dec 17 22:14:08 volumio1 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 17 22:14:08 volumio1 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 17 22:14:08 volumio1 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 17 22:14:08 volumio1 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 17 22:14:08 volumio1 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:08 volumio1 systemd[1]: shairport-sync.service: Consumed 1.850s CPU time. Dec 17 22:14:08 volumio1 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:08 volumio1 sudo[26806]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:08 volumio1 volumio[1283]: info: Shairport-Sync Started Dec 17 22:14:08 volumio1 sudo[26813]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 22:14:08 volumio1 sudo[26813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 17 22:14:08 volumio1 sudo[26813]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:08 volumio1 G20[6515]: 2025-12-17 22:14:08 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:09 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:09 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:09 volumio1 volumio[1283]: 0 bytes copied, 0.000297 s, 0.0 kB/s Dec 17 22:14:09 volumio1 mpd[26832]: 2025-12-17T22:14:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 17 22:14:09 volumio1 systemd[1]: Started mpd.service - Music Player Daemon. Dec 17 22:14:09 volumio1 sudo[26794]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:09 volumio1 volumio[1283]: error: updateQueue error: null Dec 17 22:14:09 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPlay Dec 17 22:14:09 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:09 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:09 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:09 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:09 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:09 volumio1 volumio[1283]: info: ControllerMpd::resume Dec 17 22:14:09 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:09 volumio1 volumio[1283]: info: sendMpdCommand play took 1 milliseconds Dec 17 22:14:10 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:10 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:10 volumio1 volumio[1283]: 0 bytes copied, 0.000116278 s, 0.0 kB/s Dec 17 22:14:11 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:11 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:11 volumio1 volumio[1283]: 0 bytes copied, 0.000115333 s, 0.0 kB/s Dec 17 22:14:11 volumio1 G20[6515]: 2025-12-17 22:14:11 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:12 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:12 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:12 volumio1 volumio[1283]: 0 bytes copied, 0.000116055 s, 0.0 kB/s Dec 17 22:14:12 volumio1 sudo[26875]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 17 22:14:12 volumio1 sudo[26875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:12 volumio1 systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 17 22:14:12 volumio1 systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 17 22:14:12 volumio1 systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 17 22:14:12 volumio1 systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 17 22:14:12 volumio1 sudo[26875]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:12 volumio1 volumio[1283]: info: Successfully started MPD Monitor Dec 17 22:14:12 volumio1 mpd_monitor.sh[26877]: MPD Monitor Service: Starting MPD Monitor Service Dec 17 22:14:13 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:13 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:13 volumio1 volumio[1283]: 0 bytes copied, 0.000120426 s, 0.0 kB/s Dec 17 22:14:14 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:14 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:14 volumio1 volumio[1283]: 0 bytes copied, 0.000153315 s, 0.0 kB/s Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 17 22:14:14 volumio1 volumio[1283]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 17 22:14:14 volumio1 volumio[1283]: info: Received Get System Version Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 22:14:14 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:14:14 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:14 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:14 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:14:14 volumio1 G20[6515]: 2025-12-17 22:14:14 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:15 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:15 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:15 volumio1 volumio[1283]: 0 bytes copied, 0.00011613 s, 0.0 kB/s Dec 17 22:14:16 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:16 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:16 volumio1 volumio[1283]: 0 bytes copied, 0.00011563 s, 0.0 kB/s Dec 17 22:14:16 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPlay Dec 17 22:14:16 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:16 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:16 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:16 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:16 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:16 volumio1 volumio[1283]: info: ControllerMpd::resume Dec 17 22:14:16 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:16 volumio1 volumio[1283]: info: sendMpdCommand play took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:17 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:17 volumio1 volumio[1283]: 0 bytes copied, 0.000114334 s, 0.0 kB/s Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::volumioNext Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::next Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::stop Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::updateTrackBlock Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrackBlock Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::serviceStop Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 3 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::serviceStop Dec 17 22:14:17 volumio1 volumio[1283]: info: ControllerMpd::stop Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 22:14:17 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:17 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand stop took 5 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::clearAddPlayTracks USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::updateTrackBlock Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrackBlock Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand stop took 0 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand clear Dec 17 22:14:17 volumio1 volumio[1283]: info: Dec 17 22:14:17 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:17 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand clear took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac" Dec 17 22:14:17 volumio1 volumio[1283]: error: updateQueue error: null Dec 17 22:14:17 volumio1 volumio[1283]: info: Dec 17 22:14:17 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:17 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:17 volumio1 volumio[1283]: info: ------------------------------ 1ms Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac" took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:17 volumio1 volumio[1283]: info: ------------------------------ 1ms Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand play took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: info: Dec 17 22:14:17 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:17 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:17 volumio1 volumio[1283]: info: Dec 17 22:14:17 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand status took 2 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand status took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:17 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"307 Kbps","isStreaming":false,"title":"Barabas (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac","trackType":"flac"} Dec 17 22:14:17 volumio1 volumio[1283]: verbose: CURRENT POSITION 4 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus stop Dec 17 22:14:17 volumio1 volumio[1283]: info: ------------------------------ 6ms Dec 17 22:14:17 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 17 22:14:17 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:17 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"270 Kbps","isStreaming":false,"title":"Barabas (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac","trackType":"flac"} Dec 17 22:14:17 volumio1 volumio[1283]: verbose: CURRENT POSITION 4 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:17 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:17 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:17 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:17 volumio1 volumio[1283]: info: ------------------------------ 13ms Dec 17 22:14:17 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:17 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:17 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:17 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:17 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:17 volumio1 G20[6515]: 2025-12-17 22:14:17 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:18 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:18 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:18 volumio1 volumio[1283]: 0 bytes copied, 0.000158778 s, 0.0 kB/s Dec 17 22:14:19 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:19 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:19 volumio1 volumio[1283]: 0 bytes copied, 0.00011624 s, 0.0 kB/s Dec 17 22:14:19 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:19 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:20 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:20 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:20 volumio1 volumio[1283]: 0 bytes copied, 0.000133352 s, 0.0 kB/s Dec 17 22:14:20 volumio1 G20[6515]: 2025-12-17 22:14:20 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:21 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:21 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:21 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:21 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:21 volumio1 volumio[1283]: 0 bytes copied, 0.000117186 s, 0.0 kB/s Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPause Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::pause Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::servicePause Dec 17 22:14:21 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreCommandRouter::servicePause Dec 17 22:14:21 volumio1 volumio[1283]: info: ControllerMpd::pause Dec 17 22:14:21 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand pause Dec 17 22:14:21 volumio1 volumio[1283]: info: Dec 17 22:14:21 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:21 volumio1 volumio[1283]: info: sendMpdCommand pause took 2 milliseconds Dec 17 22:14:21 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:21 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:21 volumio1 volumio[1283]: info: sendMpdCommand status took 1 milliseconds Dec 17 22:14:21 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:21 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:21 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 17 22:14:21 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:21 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:21 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:21 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5226,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"567 Kbps","isStreaming":false,"title":"Barabas (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/05. Barabas.flac","trackType":"flac"} Dec 17 22:14:21 volumio1 volumio[1283]: verbose: CURRENT POSITION 4 Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService pause Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:21 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:21 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:21 volumio1 volumio[1283]: info: ------------------------------ 9ms Dec 17 22:14:21 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:21 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:22 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:22 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:22 volumio1 volumio[1283]: 0 bytes copied, 0.0002405 s, 0.0 kB/s Dec 17 22:14:22 volumio1 volumio[1283]: info: Enabling plugin fusiondsp Dec 17 22:14:22 volumio1 volumio[1283]: info: Loading plugin "fusiondsp"... Dec 17 22:14:22 volumio1 volumio[1283]: info: Applying required configuration parameters for plugin fusiondsp Dec 17 22:14:22 volumio1 volumio[1283]: info: Preparing to generate the ALSA configuration file Dec 17 22:14:22 volumio1 volumio[1283]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 17 22:14:22 volumio1 volumio[1283]: info: Reading ALSA contributions from plugins. Dec 17 22:14:22 volumio1 volumio[1283]: info: Asound.conf file written Dec 17 22:14:22 volumio1 sudo[26961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 17 22:14:22 volumio1 sudo[26961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 sudo[26961]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:22 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 17 22:14:22 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 17 22:14:22 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:14:22 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0099" "" "" Dec 17 22:14:22 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:14:22 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:14:22 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:14:22 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3086" "" "" Dec 17 22:14:22 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:14:22 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:14:22 volumio1 volumio[1283]: info: Output device has changed, restarting MPD Dec 17 22:14:22 volumio1 volumio[1283]: info: Output device has changed, restarting Shairport Sync Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:22 volumio1 sudo[26967]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 22:14:22 volumio1 sudo[26967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 sudo[26967]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:22 volumio1 sudo[26970]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 22:14:22 volumio1 sudo[26970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 volumio[1283]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 22:14:22 volumio1 volumio[1283]: info: PLUGIN START: fusiondsp Dec 17 22:14:22 volumio1 volumio[1283]: info: FusionDsp - CamillaDSP binary found. Dec 17 22:14:22 volumio1 volumio[1283]: info: Loading i18n strings for locale en Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: FusionDsp - mixtype--------------------- None Dec 17 22:14:22 volumio1 volumio[1283]: info: Preparing to generate the ALSA configuration file Dec 17 22:14:22 volumio1 systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 17 22:14:22 volumio1 volumio[1283]: info: Done. Dec 17 22:14:22 volumio1 volumio[1283]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 17 22:14:22 volumio1 volumio[1283]: info: Reading ALSA contributions from plugins. Dec 17 22:14:22 volumio1 volumio[1283]: info: MPD Permissions set Dec 17 22:14:22 volumio1 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:22 volumio1 volumio[1283]: info: Starting Shairport Sync Dec 17 22:14:22 volumio1 volumio[1283]: info: Asound.conf file unchanged, so no further update is needed Dec 17 22:14:22 volumio1 volumio[1283]: info: Output device has changed, restarting MPD Dec 17 22:14:22 volumio1 systemd[1]: mpd.service: Deactivated successfully. Dec 17 22:14:22 volumio1 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 17 22:14:22 volumio1 systemd[1]: mpd.service: Consumed 1.672s CPU time. Dec 17 22:14:22 volumio1 systemd[1]: mpd.socket: Deactivated successfully. Dec 17 22:14:22 volumio1 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 17 22:14:22 volumio1 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 17 22:14:22 volumio1 sudo[26984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 22:14:22 volumio1 sudo[26984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 volumio[1283]: info: Output device has changed, restarting Shairport Sync Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:22 volumio1 sudo[26986]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 22:14:22 volumio1 sudo[26986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 sudo[26986]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:22 volumio1 volumio[1283]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 22:14:22 volumio1 sudo[26990]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 22:14:22 volumio1 sudo[26990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:22 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Dec 17 22:14:22 volumio1 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 17 22:14:22 volumio1 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 17 22:14:22 volumio1 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 17 22:14:22 volumio1 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 17 22:14:22 volumio1 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:22 volumio1 systemd[1]: shairport-sync.service: Consumed 1.594s CPU time. Dec 17 22:14:22 volumio1 systemd[1]: mpd.service: Deactivated successfully. Dec 17 22:14:22 volumio1 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 17 22:14:22 volumio1 systemd[1]: mpd.socket: Deactivated successfully. Dec 17 22:14:22 volumio1 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 17 22:14:22 volumio1 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 17 22:14:22 volumio1 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 17 22:14:22 volumio1 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 17 22:14:22 volumio1 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:22 volumio1 sudo[26984]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:22 volumio1 volumio[1283]: info: MPD Permissions set Dec 17 22:14:22 volumio1 volumio[1283]: info: Shairport-Sync Started Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:22 volumio1 volumio[1283]: info: Starting Shairport Sync Dec 17 22:14:23 volumio1 sudo[27021]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 22:14:23 volumio1 sudo[27021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:23 volumio1 sudo[26999]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 22:14:23 volumio1 sudo[26999]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 17 22:14:23 volumio1 sudo[26999]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:23 volumio1 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 17 22:14:23 volumio1 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 17 22:14:23 volumio1 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:23 volumio1 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:14:23 volumio1 sudo[27021]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:23 volumio1 volumio[1283]: info: Shairport-Sync Started Dec 17 22:14:23 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:23 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:23 volumio1 volumio[1283]: 0 bytes copied, 0.000156666 s, 0.0 kB/s Dec 17 22:14:23 volumio1 G20[6515]: 2025-12-17 22:14:23 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:23 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPlay Dec 17 22:14:23 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:23 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:23 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:23 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:23 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:23 volumio1 volumio[1283]: info: ControllerMpd::resume Dec 17 22:14:23 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:24 volumio1 mpd[27024]: 2025-12-17T22:14:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 17 22:14:24 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:24 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:24 volumio1 volumio[1283]: 0 bytes copied, 0.000128241 s, 0.0 kB/s Dec 17 22:14:24 volumio1 systemd[1]: Started mpd.service - Music Player Daemon. Dec 17 22:14:24 volumio1 sudo[26970]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:24 volumio1 sudo[26990]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:24 volumio1 volumio[1283]: error: MPD error: The expression evaluated to a falsy value: Dec 17 22:14:24 volumio1 volumio[1283]: assert.ok(self.idling) Dec 17 22:14:24 volumio1 volumio[1283]: error: The expression evaluated to a falsy value: Dec 17 22:14:24 volumio1 volumio[1283]: assert.ok(self.idling) Dec 17 22:14:24 volumio1 volumio[1283]: error: updateQueue error: null Dec 17 22:14:24 volumio1 volumio[1283]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Dec 17 22:14:24 volumio1 volumio[1283]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 17 22:14:24 volumio1 volumio[1283]: info: camilladsp service started and running in background, instance 5 Dec 17 22:14:24 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp loaded Dec 17 22:14:24 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 17 22:14:24 volumio1 volumio[1283]: info: Adding Signal Path Element [object Object] Dec 17 22:14:24 volumio1 volumio[1283]: info: Adding fusiondspeq DSP Signal Path Element Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- installed callbackRead Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 sudo[27068]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 17 22:14:24 volumio1 sudo[27068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:24 volumio1 volumio[1283]: info: camilladsp stopping service pid 27061... Dec 17 22:14:24 volumio1 volumio[1283]: info: camilladsp service terminated, instance 5 Dec 17 22:14:24 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:24 volumio1 volumio[1283]: info: camilladsp service started and running in background, instance 5 Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:24 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:24 volumio1 systemd[1]: Started fusiondsp.service - FusionDsp Daemon. Dec 17 22:14:24 volumio1 sudo[27068]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:25 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:25 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:25 volumio1 volumio[1283]: 0 bytes copied, 0.000274186 s, 0.0 kB/s Dec 17 22:14:25 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:25 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:25 volumio1 volumio[1283]: 0 bytes copied, 0.000134611 s, 0.0 kB/s Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioNext Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::next Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::stop Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::updateTrackBlock Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrackBlock Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::serviceStop Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 4 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::serviceStop Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::stop Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand stop took 5 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::clearAddPlayTracks USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::updateTrackBlock Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrackBlock Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand stop took 1 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand clear Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:26 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand clear took 1 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac" Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:26 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:26 volumio1 volumio[1283]: error: updateQueue error: null Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:26 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 2ms Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac" took 1 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 2ms Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:26 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 4ms Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand play took 3 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 3ms Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand status took 37 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand status took 38 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:26 volumio1 volumio[1283]: info: Dec 17 22:14:26 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand status took 4 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand status took 2 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"621 Kbps","isStreaming":false,"title":"Cinderella","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac","trackType":"flac"} Dec 17 22:14:26 volumio1 volumio[1283]: verbose: CURRENT POSITION 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus stop Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"633 Kbps","isStreaming":false,"title":"Cinderella","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac","trackType":"flac"} Dec 17 22:14:26 volumio1 volumio[1283]: verbose: CURRENT POSITION 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:26 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 50ms Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 60ms Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:26 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1581,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"Cinderella","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac","trackType":"flac"} Dec 17 22:14:26 volumio1 volumio[1283]: verbose: CURRENT POSITION 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:26 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1581,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"Cinderella","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/06. Cinderella.flac","trackType":"flac"} Dec 17 22:14:26 volumio1 volumio[1283]: verbose: CURRENT POSITION 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:26 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:26 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:26 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 58ms Dec 17 22:14:26 volumio1 volumio[1283]: info: ------------------------------ 55ms Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:26 volumio1 G20[6515]: 2025-12-17 22:14:26 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:27 volumio1 sudo[27430]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 17 22:14:27 volumio1 sudo[27430]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:27 volumio1 sudo[27432]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 17 22:14:27 volumio1 sudo[27432]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:27 volumio1 systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 17 22:14:27 volumio1 systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 17 22:14:27 volumio1 systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 17 22:14:27 volumio1 systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 17 22:14:27 volumio1 sudo[27430]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:27 volumio1 sudo[27432]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:27 volumio1 mpd_monitor.sh[27451]: MPD Monitor Service: Starting MPD Monitor Service Dec 17 22:14:27 volumio1 volumio[1283]: info: Successfully started MPD Monitor Dec 17 22:14:27 volumio1 volumio[1283]: info: Successfully started MPD Monitor Dec 17 22:14:28 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:28 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:29 volumio1 G20[6515]: 2025-12-17 22:14:29 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:30 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:32 volumio1 G20[6515]: 2025-12-17 22:14:32 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:34 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:35 volumio1 volumio[1283]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Dec 17 22:14:35 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Dec 17 22:14:35 volumio1 volumio[1283]: info: FusionDsp - Launching CamillaDsp GUI Dec 17 22:14:35 volumio1 volumio[1283]: info: FusionDsp loaded Dec 17 22:14:35 volumio1 sudo[30597]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 17 22:14:35 volumio1 sudo[30597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:35 volumio1 sudo[30597]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:35 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:35 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:35 volumio1 G20[6515]: 2025-12-17 22:14:35 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:35 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:35 volumio1 volumio[1283]: info: CoreCommandRouter::Close All Modals sent Dec 17 22:14:35 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:14:36 volumio1 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 17 22:14:36 volumio1 systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 17 22:14:36 volumio1 systemd[1]: welcome.service: Deactivated successfully. Dec 17 22:14:36 volumio1 systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 17 22:14:36 volumio1 systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 17 22:14:36 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:36 volumio1 volumio[1283]: 1+39 records in Dec 17 22:14:36 volumio1 volumio[1283]: 1+39 records out Dec 17 22:14:36 volumio1 volumio[1283]: 211136 bytes (211 kB, 206 KiB) copied, 0.000911167 s, 232 MB/s Dec 17 22:14:36 volumio1 systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 17 22:14:36 volumio1 welcome[30659]: Resolved ip:[1] 192.168.0.89 Dec 17 22:14:36 volumio1 systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 17 22:14:36 volumio1 systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:36 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:37 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:37 volumio1 volumio[1283]: 1+15 records in Dec 17 22:14:37 volumio1 volumio[1283]: 1+15 records out Dec 17 22:14:37 volumio1 volumio[1283]: 115664 bytes (116 kB, 113 KiB) copied, 0.000481797 s, 240 MB/s Dec 17 22:14:38 volumio1 volumio[27074]: ERROR:root:Statefile could not be opened: /data/configuration/audio_interface/fusiondsp/statefile.yml Dec 17 22:14:38 volumio1 volumio[27074]: ERROR:root:Details: [Errno 2] No such file or directory: '/data/configuration/audio_interface/fusiondsp/statefile.yml' Dec 17 22:14:38 volumio1 volumio[27074]: WARNING:root:The config file path is None Dec 17 22:14:38 volumio1 volumio[27074]: ERROR:root:Failed to get active config Dec 17 22:14:38 volumio1 volumio[27074]: Traceback (most recent call last): Dec 17 22:14:38 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/views.py", line 397, in get_active_config_file Dec 17 22:14:38 volumio1 volumio[27074]: config_object = make_config_filter_paths_relative( Dec 17 22:14:38 volumio1 volumio[27074]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 17 22:14:38 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 359, in make_config_filter_paths_relative Dec 17 22:14:38 volumio1 volumio[27074]: return convert_config_filter_paths(config_object, conversion) Dec 17 22:14:38 volumio1 volumio[27074]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 17 22:14:38 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 367, in convert_config_filter_paths Dec 17 22:14:38 volumio1 volumio[27074]: filters = config.get("filters") Dec 17 22:14:38 volumio1 volumio[27074]: ^^^^^^^^^^ Dec 17 22:14:38 volumio1 volumio[27074]: AttributeError: 'NoneType' object has no attribute 'get' Dec 17 22:14:38 volumio1 G20[6515]: 2025-12-17 22:14:38 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:38 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:38 volumio1 volumio[1283]: 1283+1 records in Dec 17 22:14:38 volumio1 volumio[1283]: 1283+1 records out Dec 17 22:14:38 volumio1 volumio[1283]: 42072080 bytes (42 MB, 40 MiB) copied, 0.294329 s, 143 MB/s Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:38 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:39 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:39 volumio1 volumio[1283]: 1+44 records in Dec 17 22:14:39 volumio1 volumio[1283]: 1+44 records out Dec 17 22:14:39 volumio1 volumio[1283]: 232800 bytes (233 kB, 227 KiB) copied, 0.000721222 s, 323 MB/s Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:40 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:41 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:41 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:41 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:41 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:41 volumio1 volumio[1283]: 41+1 records in Dec 17 22:14:41 volumio1 volumio[1283]: 41+1 records out Dec 17 22:14:41 volumio1 volumio[1283]: 1375856 bytes (1.4 MB, 1.3 MiB) copied, 0.0076771 s, 179 MB/s Dec 17 22:14:41 volumio1 G20[6515]: 2025-12-17 22:14:41 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:42 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:42 volumio1 volumio[1283]: 1+44 records in Dec 17 22:14:42 volumio1 volumio[1283]: 1+44 records out Dec 17 22:14:42 volumio1 volumio[1283]: 231632 bytes (232 kB, 226 KiB) copied, 0.000706649 s, 328 MB/s Dec 17 22:14:42 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:42 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:42 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:43 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:43 volumio1 volumio[1283]: 1+33 records in Dec 17 22:14:43 volumio1 volumio[1283]: 1+33 records out Dec 17 22:14:43 volumio1 volumio[1283]: 189248 bytes (189 kB, 185 KiB) copied, 0.000657963 s, 288 MB/s Dec 17 22:14:44 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:44 volumio1 volumio[1283]: 595+40 records in Dec 17 22:14:44 volumio1 volumio[1283]: 595+40 records out Dec 17 22:14:44 volumio1 volumio[1283]: 19679680 bytes (20 MB, 19 MiB) copied, 0.134219 s, 147 MB/s Dec 17 22:14:44 volumio1 G20[6515]: 2025-12-17 22:14:44 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:45 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:45 volumio1 volumio[1283]: 169+1 records in Dec 17 22:14:45 volumio1 volumio[1283]: 169+1 records out Dec 17 22:14:45 volumio1 volumio[1283]: 5567440 bytes (5.6 MB, 5.3 MiB) copied, 0.0325825 s, 171 MB/s Dec 17 22:14:46 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:46 volumio1 volumio[1283]: 1+12 records in Dec 17 22:14:46 volumio1 volumio[1283]: 1+12 records out Dec 17 22:14:46 volumio1 volumio[1283]: 105776 bytes (106 kB, 103 KiB) copied, 0.000560926 s, 189 MB/s Dec 17 22:14:46 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:46 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:47 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:47 volumio1 volumio[1283]: 1+42 records in Dec 17 22:14:47 volumio1 volumio[1283]: 1+42 records out Dec 17 22:14:47 volumio1 volumio[1283]: 224448 bytes (224 kB, 219 KiB) copied, 0.000884556 s, 254 MB/s Dec 17 22:14:47 volumio1 G20[6515]: 2025-12-17 22:14:47 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:48 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:48 volumio1 volumio[1283]: 117+1 records in Dec 17 22:14:48 volumio1 volumio[1283]: 117+1 records out Dec 17 22:14:48 volumio1 volumio[1283]: 3849216 bytes (3.8 MB, 3.7 MiB) copied, 0.0498519 s, 77.2 MB/s Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 3 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 5 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 5 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService stop Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::play index undefined Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::startPlaybackTimer Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::clearAddPlayTracks USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand stop Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 15ms Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 18 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand stop took 6 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand clear Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService stop Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus stop Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: No code Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 31ms Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:48 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand clear took 31 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac" Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:48 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:48 volumio1 volumio[1283]: error: updateQueue error: null Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:48 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 3ms Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand add "USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac" took 3 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 2ms Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand play Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces system playlist update Dec 17 22:14:48 volumio1 volumio[1283]: info: Ignoring MPD Status Update Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 6ms Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand play took 5 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 4ms Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 3 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:48 volumio1 volumio[1283]: info: Dec 17 22:14:48 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 19 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 17 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand status took 16 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus stop Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 27ms Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:48 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":596,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1147 Kbps","isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:48 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1120 Kbps","isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:48 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1108 Kbps","isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:48 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService play Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus play Dec 17 22:14:48 volumio1 volumio[1283]: info: Received an update from plugin. extracting info from payload Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:48 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:48 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 58ms Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 57ms Dec 17 22:14:48 volumio1 volumio[1283]: info: ------------------------------ 56ms Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Reload WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: info: FusionDsp - Volumio is playing Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:48 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:49 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:49 volumio1 volumio[1283]: 1+31 records in Dec 17 22:14:49 volumio1 volumio[1283]: 1+31 records out Dec 17 22:14:49 volumio1 volumio[1283]: 183328 bytes (183 kB, 179 KiB) copied, 0.000609297 s, 301 MB/s Dec 17 22:14:50 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:50 volumio1 volumio[1283]: 1+33 records in Dec 17 22:14:50 volumio1 volumio[1283]: 1+33 records out Dec 17 22:14:50 volumio1 volumio[1283]: 189472 bytes (189 kB, 185 KiB) copied, 0.000849278 s, 223 MB/s Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:50 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 17 22:14:50 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 17 22:14:50 volumio1 G20[6515]: 2025-12-17 22:14:50 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 sudo[30773]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 sudo[30773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 sudo[30773]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 sudo[30775]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 17 22:14:51 volumio1 sudo[30775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 sudo[30775]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - Monitor WebSocket error: [object Object] Dec 17 22:14:51 volumio1 volumio[1283]: verbose: New Socket.io Connection to 192.168.0.89 from 192.168.0.156 UA: Mozilla/5.0 (Linux; Android 16; SM-F946B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Dec 17 22:14:51 volumio1 sudo[30779]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 17 22:14:51 volumio1 sudo[30779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:51 volumio1 sudo[30779]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:51 volumio1 sudo[30781]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 17 22:14:51 volumio1 sudo[30781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:14:51 volumio1 sudo[30781]: pam_unix(sudo:session): session closed for user root Dec 17 22:14:51 volumio1 volumio[1283]: verbose: New Socket.io Connection to 192.168.0.89 from 192.168.0.156 UA: Mozilla/5.0 (Linux; Android 16; SM-F946B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:51 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 17 22:14:51 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:14:51 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:51 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:51 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:51 volumio1 volumio[1283]: info: Listing playlists Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 17 22:14:51 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:51 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:14:51 volumio1 volumio[1283]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Dec 17 22:14:51 volumio1 volumio[1283]: 1+7 records in Dec 17 22:14:51 volumio1 volumio[1283]: 1+7 records out Dec 17 22:14:51 volumio1 volumio[1283]: 88640 bytes (89 kB, 87 KiB) copied, 0.00052013 s, 170 MB/s Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::pause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::servicePause Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::servicePause Dec 17 22:14:52 volumio1 volumio[1283]: info: ControllerMpd::pause Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand pause Dec 17 22:14:52 volumio1 volumio[1283]: info: Dec 17 22:14:52 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:52 volumio1 volumio[1283]: info: sendMpdCommand pause took 1 milliseconds Dec 17 22:14:52 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:52 volumio1 volumio[1283]: info: Dec 17 22:14:52 volumio1 volumio[1283]: ---------------------------- MPD announces state update: player Dec 17 22:14:52 volumio1 volumio[1283]: info: ControllerMpd::getState Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand status Dec 17 22:14:52 volumio1 volumio[1283]: info: sendMpdCommand status took 2 milliseconds Dec 17 22:14:52 volumio1 volumio[1283]: info: sendMpdCommand status took 1 milliseconds Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::parseState Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 17 22:14:52 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 17 22:14:52 volumio1 volumio[1283]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:52 volumio1 volumio[1283]: verbose: ControllerMpd::parseTrackInfo Dec 17 22:14:52 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6350,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:52 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService pause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:52 volumio1 volumio[1283]: info: ControllerMpd::pushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::servicePushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6350,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1149 Kbps","isStreaming":false,"title":"Nr. 9 (Album Version)","artist":"Hooverphonic","album":"A New Stereophonic Sound Spectacular","uri":"USB/HiBy/Music/Hooverphonic/1996 - A New Stereophonic Sound Spectacular [16B-44.1kHz]/07. Nr. 9.flac","trackType":"flac"} Dec 17 22:14:52 volumio1 volumio[1283]: verbose: CURRENT POSITION 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::syncState stateService pause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::syncState currentStatus pause Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::pushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPushState Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreStateMachine::stPlaybackTimer Dec 17 22:14:52 volumio1 volumio[1283]: info: ------------------------------ 13ms Dec 17 22:14:52 volumio1 volumio[1283]: info: ------------------------------ 12ms Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Volumio is not playing Dec 17 22:14:52 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:14:52 volumio1 volumio[1283]: 0+1 records in Dec 17 22:14:52 volumio1 volumio[1283]: 0+1 records out Dec 17 22:14:52 volumio1 volumio[1283]: 19760 bytes (20 kB, 19 KiB) copied, 0.000188815 s, 105 MB/s Dec 17 22:14:52 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:14:53 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:14:53 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:53 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:14:53 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:53 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:53 volumio1 volumio[1283]: 0 bytes copied, 0.000117408 s, 0.0 kB/s Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:14:53 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:14:53 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:14:53 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:14:53 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:14:53 volumio1 G20[6515]: 2025-12-17 22:14:53 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:54 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:54 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:54 volumio1 volumio[1283]: 0 bytes copied, 0.0001145 s, 0.0 kB/s Dec 17 22:14:54 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:14:54 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:14:54 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:54 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:54 volumio1 volumio[1283]: 0 bytes copied, 0.000114166 s, 0.0 kB/s Dec 17 22:14:55 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:55 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:55 volumio1 volumio[1283]: 0 bytes copied, 0.000115908 s, 0.0 kB/s Dec 17 22:14:55 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:55 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:55 volumio1 volumio[1283]: 0 bytes copied, 0.000119056 s, 0.0 kB/s Dec 17 22:14:56 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:56 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:56 volumio1 volumio[1283]: 0 bytes copied, 0.000116445 s, 0.0 kB/s Dec 17 22:14:56 volumio1 volumio[27074]: ERROR:root:Statefile could not be opened: /data/configuration/audio_interface/fusiondsp/statefile.yml Dec 17 22:14:56 volumio1 volumio[27074]: ERROR:root:Details: [Errno 2] No such file or directory: '/data/configuration/audio_interface/fusiondsp/statefile.yml' Dec 17 22:14:56 volumio1 volumio[27074]: WARNING:root:The config file path is None Dec 17 22:14:56 volumio1 volumio[27074]: ERROR:root:Failed to get active config Dec 17 22:14:56 volumio1 volumio[27074]: Traceback (most recent call last): Dec 17 22:14:56 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/views.py", line 397, in get_active_config_file Dec 17 22:14:56 volumio1 volumio[27074]: config_object = make_config_filter_paths_relative( Dec 17 22:14:56 volumio1 volumio[27074]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 17 22:14:56 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 359, in make_config_filter_paths_relative Dec 17 22:14:56 volumio1 volumio[27074]: return convert_config_filter_paths(config_object, conversion) Dec 17 22:14:56 volumio1 volumio[27074]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 17 22:14:56 volumio1 volumio[27074]: File "/data/plugins/audio_interface/fusiondsp/cgui/backend/filemanagement.py", line 367, in convert_config_filter_paths Dec 17 22:14:56 volumio1 volumio[27074]: filters = config.get("filters") Dec 17 22:14:56 volumio1 volumio[27074]: ^^^^^^^^^^ Dec 17 22:14:56 volumio1 volumio[27074]: AttributeError: 'NoneType' object has no attribute 'get' Dec 17 22:14:56 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:56 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:56 volumio1 volumio[1283]: 0 bytes copied, 0.000115371 s, 0.0 kB/s Dec 17 22:14:56 volumio1 G20[6515]: 2025-12-17 22:14:56 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:14:57 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:57 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:57 volumio1 volumio[1283]: 0 bytes copied, 0.000114112 s, 0.0 kB/s Dec 17 22:14:57 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:57 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:57 volumio1 volumio[1283]: 0 bytes copied, 0.000116222 s, 0.0 kB/s Dec 17 22:14:58 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:58 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:58 volumio1 volumio[1283]: 0 bytes copied, 0.000113723 s, 0.0 kB/s Dec 17 22:14:58 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:58 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:58 volumio1 volumio[1283]: 0 bytes copied, 9.9852e-05 s, 0.0 kB/s Dec 17 22:14:59 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:59 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:59 volumio1 volumio[1283]: 0 bytes copied, 0.000115482 s, 0.0 kB/s Dec 17 22:14:59 volumio1 volumio[1283]: 0+0 records in Dec 17 22:14:59 volumio1 volumio[1283]: 0+0 records out Dec 17 22:14:59 volumio1 volumio[1283]: 0 bytes copied, 0.000115815 s, 0.0 kB/s Dec 17 22:14:59 volumio1 G20[6515]: 2025-12-17 22:14:59 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:15:00 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:00 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:00 volumio1 volumio[1283]: 0 bytes copied, 0.000116722 s, 0.0 kB/s Dec 17 22:15:00 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:00 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:00 volumio1 volumio[1283]: 0 bytes copied, 0.000114759 s, 0.0 kB/s Dec 17 22:15:00 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 17 22:15:00 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 17 22:15:01 volumio1 sudo[30904]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 17 22:15:01 volumio1 sudo[30904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:01 volumio1 sudo[30904]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:01 volumio1 sudo[30906]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 17 22:15:01 volumio1 sudo[30906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:01 volumio1 sudo[30906]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:01 volumio1 volumio[1283]: verbose: New Socket.io Connection to 192.168.0.89 from 192.168.0.156 UA: Mozilla/5.0 (Linux; Android 16; SM-F946B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Dec 17 22:15:01 volumio1 sudo[30910]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 17 22:15:01 volumio1 sudo[30910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:01 volumio1 sudo[30910]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:01 volumio1 sudo[30912]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 17 22:15:01 volumio1 sudo[30912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:01 volumio1 sudo[30912]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:01 volumio1 volumio[1283]: verbose: New Socket.io Connection to 192.168.0.89 from 192.168.0.156 UA: Mozilla/5.0 (Linux; Android 16; SM-F946B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Dec 17 22:15:01 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:01 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:01 volumio1 volumio[1283]: 0 bytes copied, 0.000116352 s, 0.0 kB/s Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:01 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 17 22:15:01 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:15:01 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:01 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:01 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:01 volumio1 volumio[1283]: info: Listing playlists Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:15:01 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:15:01 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 17 22:15:01 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:01 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:01 volumio1 volumio[1283]: 0 bytes copied, 0.000101185 s, 0.0 kB/s Dec 17 22:15:02 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:02 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:02 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:02 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:02 volumio1 volumio[1283]: 0 bytes copied, 9.9519e-05 s, 0.0 kB/s Dec 17 22:15:02 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:02 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:02 volumio1 volumio[1283]: 0 bytes copied, 0.000115445 s, 0.0 kB/s Dec 17 22:15:02 volumio1 G20[6515]: 2025-12-17 22:15:02 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:15:02 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:15:03 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:15:03 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:03 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:15:03 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:03 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:03 volumio1 volumio[1283]: 0 bytes copied, 0.000115333 s, 0.0 kB/s Dec 17 22:15:03 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:03 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:03 volumio1 volumio[1283]: 0 bytes copied, 0.0001135 s, 0.0 kB/s Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:15:03 volumio1 volumio[1283]: info: Received Get System Info Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 17 22:15:03 volumio1 volumio[1283]: info: Discovery: Getting this device information Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::volumioGetState Dec 17 22:15:03 volumio1 volumio[1283]: info: CorePlayQueue::getTrack 6 Dec 17 22:15:03 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 22:15:04 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:04 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:04 volumio1 volumio[1283]: 0 bytes copied, 0.000122166 s, 0.0 kB/s Dec 17 22:15:04 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:15:04 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 17 22:15:04 volumio1 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 17 22:15:04 volumio1 volumio[1283]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//purecgui' Dec 17 22:15:04 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:04 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:04 volumio1 volumio[1283]: 0 bytes copied, 0.000114833 s, 0.0 kB/s Dec 17 22:15:05 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:05 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:05 volumio1 volumio[1283]: 0 bytes copied, 0.000115167 s, 0.0 kB/s Dec 17 22:15:05 volumio1 G20[6515]: 2025-12-17 22:15:05 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:15:05 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:05 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:05 volumio1 volumio[1283]: 0 bytes copied, 0.000141297 s, 0.0 kB/s Dec 17 22:15:06 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:06 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:06 volumio1 volumio[1283]: 0 bytes copied, 0.000114149 s, 0.0 kB/s Dec 17 22:15:06 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:06 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:06 volumio1 volumio[1283]: 0 bytes copied, 0.000117315 s, 0.0 kB/s Dec 17 22:15:07 volumio1 volumio[1283]: info: Starting Uninstall of plugin audio_interface - fusiondsp Dec 17 22:15:07 volumio1 volumio[1283]: info: Uninstalling plugin fusiondsp Dec 17 22:15:07 volumio1 volumio[1283]: info: FusionDsp - Stopping clipped samples monitor Dec 17 22:15:07 volumio1 volumio[1283]: info: FusionDsp - Clipped samples monitor stopped Dec 17 22:15:07 volumio1 volumio[1283]: info: FusionDsp - Stopping FusionDsp service Dec 17 22:15:07 volumio1 volumio[1283]: info: camilladsp service terminated, instance 5 Dec 17 22:15:07 volumio1 volumio[1283]: info: Disabling plugin fusiondsp Dec 17 22:15:07 volumio1 volumio[1283]: info: Preparing to generate the ALSA configuration file Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::volumioPause Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreStateMachine::pause Dec 17 22:15:07 volumio1 sudo[31003]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 17 22:15:07 volumio1 sudo[31003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 volumio[1283]: info: Asound.conf file written Dec 17 22:15:07 volumio1 sudo[31007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 17 22:15:07 volumio1 sudo[31007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 systemd[1]: Stopping fusiondsp.service - FusionDsp Daemon... Dec 17 22:15:07 volumio1 volumio[27074]: ======== Running on http://0.0.0.0:5011 ======== Dec 17 22:15:07 volumio1 volumio[27074]: (Press CTRL+C to quit) Dec 17 22:15:07 volumio1 sudo[31007]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:07 volumio1 systemd[1]: fusiondsp.service: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon. Dec 17 22:15:07 volumio1 systemd[1]: fusiondsp.service: Consumed 1.286s CPU time. Dec 17 22:15:07 volumio1 sudo[31003]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:07 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 17 22:15:07 volumio1 volumio[1283]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 17 22:15:07 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:15:07 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB2972:0099" "" "" Dec 17 22:15:07 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:15:07 volumio1 volumio[1283]: No state is present for card R2R Dec 17 22:15:07 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:15:07 volumio1 volumio[1283]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3086" "" "" Dec 17 22:15:07 volumio1 volumio[1283]: Hardware is initialized using a generic method Dec 17 22:15:07 volumio1 volumio[1283]: No state is present for card G3 Dec 17 22:15:07 volumio1 volumio[1283]: info: Output device has changed, restarting MPD Dec 17 22:15:07 volumio1 volumio[1283]: info: Output device has changed, restarting Shairport Sync Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:15:07 volumio1 sudo[31013]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 22:15:07 volumio1 sudo[31013]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 sudo[31013]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:07 volumio1 volumio[1283]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 22:15:07 volumio1 sudo[31017]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 22:15:07 volumio1 sudo[31017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 volumio[1283]: info: Checking if uninstall.sh is present Dec 17 22:15:07 volumio1 volumio[1283]: info: MPD Permissions set Dec 17 22:15:07 volumio1 volumio[1283]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 17 22:15:07 volumio1 volumio[1283]: info: Removing fusiondspeq DSP Signal Path Element Dec 17 22:15:07 volumio1 volumio[1283]: info: Executing uninstall.sh Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 22:15:07 volumio1 volumio[1283]: info: Starting Shairport Sync Dec 17 22:15:07 volumio1 sudo[31024]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Dec 17 22:15:07 volumio1 sudo[31024]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 sudo[31031]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 22:15:07 volumio1 sudo[31031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 22:15:07 volumio1 systemd[1]: mpd.service: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 17 22:15:07 volumio1 systemd[1]: mpd.service: Consumed 3.096s CPU time. Dec 17 22:15:07 volumio1 systemd[1]: mpd.socket: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 17 22:15:07 volumio1 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 17 22:15:07 volumio1 mpd_monitor.sh[31035]: MPD error: Connection reset by peer Dec 17 22:15:07 volumio1 mpd_monitor.sh[27451]: MPD Monitor Service: MPD Appears to be inactive, restarting Dec 17 22:15:07 volumio1 mpd_monitor.sh[31039]: mpd: no process found Dec 17 22:15:07 volumio1 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 17 22:15:07 volumio1 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 17 22:15:07 volumio1 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 17 22:15:07 volumio1 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:15:07 volumio1 systemd[1]: shairport-sync.service: Consumed 1.744s CPU time. Dec 17 22:15:07 volumio1 sudo[31043]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/fusiondsp.service Dec 17 22:15:07 volumio1 sudo[31043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 17 22:15:07 volumio1 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 17 22:15:07 volumio1 volumio[1283]: info: Shairport-Sync Started Dec 17 22:15:07 volumio1 sudo[31031]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:07 volumio1 sudo[31043]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:07 volumio1 systemd[1]: mpd.service: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 17 22:15:07 volumio1 systemd[1]: mpd.socket: Deactivated successfully. Dec 17 22:15:07 volumio1 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 17 22:15:07 volumio1 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 17 22:15:07 volumio1 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 17 22:15:07 volumio1 sudo[31046]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Dec 17 22:15:07 volumio1 sudo[31046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 17 22:15:07 volumio1 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 17 22:15:07 volumio1 systemd[1]: Reloading. Dec 17 22:15:08 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:08 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:08 volumio1 volumio[1283]: 0 bytes copied, 0.000285963 s, 0.0 kB/s Dec 17 22:15:08 volumio1 sudo[31048]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 22:15:08 volumio1 sudo[31048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 17 22:15:08 volumio1 sudo[31048]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:08 volumio1 sudo[31046]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:08 volumio1 sudo[31024]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:08 volumio1 volumio[1283]: info: Uninstall script completed Dec 17 22:15:08 volumio1 volumio[1283]: info: Removing plugin fusiondsp from configuration Dec 17 22:15:08 volumio1 G20[6515]: 2025-12-17 22:15:08 - Waiting for G20BTS Keyboard to be connected... Dec 17 22:15:09 volumio1 volumio[1283]: info: Successfully removed fusiondsp configuration files Dec 17 22:15:09 volumio1 volumio[1283]: info: Plugin folders cleanup Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning into folder /volumio/app/plugins/ Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category audio_interface Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category miscellanea Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category music_service Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category plugins.json Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category system_controller Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category user_interface Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning into folder /data/plugins/ Dec 17 22:15:09 volumio1 volumio[1283]: info: Scanning category audio_interface Dec 17 22:15:09 volumio1 volumio[1283]: info: Cleaning folder for fusiondsp Dec 17 22:15:10 volumio1 volumio[1283]: info: Scanning category system_controller Dec 17 22:15:10 volumio1 volumio[1283]: info: Plugin folders cleanup completed Dec 17 22:15:10 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 22:15:10 volumio1 volumio[1283]: info: [{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"1.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true}] Dec 17 22:15:10 volumio1 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 17 22:15:10 volumio1 volumio[1283]: 0+0 records in Dec 17 22:15:10 volumio1 volumio[1283]: 0+0 records out Dec 17 22:15:10 volumio1 volumio[1283]: 0 bytes copied, 0.0001215 s, 0.0 kB/s Dec 17 22:15:10 volumio1 volumio[1283]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 22:15:10 volumio1 volumio[1283]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 17 22:15:10 volumio1 volumio[1283]: at ChildProcess._handle.onexit (node:internal/child_process:286:19) Dec 17 22:15:10 volumio1 volumio[1283]: at onErrorNT (node:internal/child_process:484:16) Dec 17 22:15:10 volumio1 volumio[1283]: at processTicksAndRejections (node:internal/process/task_queues:82:21) Dec 17 22:15:10 volumio1 volumio[1283]: at runNextTicks (node:internal/process/task_queues:64:3) Dec 17 22:15:10 volumio1 volumio[1283]: at listOnTimeout (node:internal/timers:540:9) Dec 17 22:15:10 volumio1 volumio[1283]: at process.processTimers (node:internal/timers:514:7) { Dec 17 22:15:10 volumio1 volumio[1283]: errno: -2, Dec 17 22:15:10 volumio1 volumio[1283]: code: 'ENOENT', Dec 17 22:15:10 volumio1 volumio[1283]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 17 22:15:10 volumio1 volumio[1283]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 17 22:15:10 volumio1 volumio[1283]: spawnargs: [ Dec 17 22:15:10 volumio1 volumio[1283]: '-p', Dec 17 22:15:10 volumio1 volumio[1283]: 9876, Dec 17 22:15:10 volumio1 volumio[1283]: '-o', Dec 17 22:15:10 volumio1 volumio[1283]: '/tmp/camilladsp.log', Dec 17 22:15:10 volumio1 volumio[1283]: '-l', Dec 17 22:15:10 volumio1 volumio[1283]: 'warn', Dec 17 22:15:10 volumio1 volumio[1283]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 17 22:15:10 volumio1 volumio[1283]: ] Dec 17 22:15:10 volumio1 volumio[1283]: } Dec 17 22:15:10 volumio1 volumio[1283]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 22:15:10 volumio1 mpd[31088]: 2025-12-17T22:15:10 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 17 22:15:10 volumio1 systemd[1]: Started mpd.service - Music Player Daemon. Dec 17 22:15:10 volumio1 mpd_monitor.sh[27451]: MPD Monitor Service: MPD restarted due to no mpc output. Dec 17 22:15:10 volumio1 sudo[31017]: pam_unix(sudo:session): session closed for user root Dec 17 22:15:10 volumio1 sudo[31117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-17 22:14' Dec 17 22:15:10 volumio1 sudo[31117]: 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"