Moode Forum
[PROBLEM] Airplay stuttering since moOde 9 - Printable Version

+- Moode Forum (https://moodeaudio.org/forum)
+-- Forum: moOde audio player (https://moodeaudio.org/forum/forumdisplay.php?fid=3)
+--- Forum: Support (https://moodeaudio.org/forum/forumdisplay.php?fid=7)
+--- Thread: [PROBLEM] Airplay stuttering since moOde 9 (/showthread.php?tid=6590)

Pages: 1 2 3 4 5


RE: Airplay stuttering since moOde 9 - TheOldPresbyope - 06-23-2024

As Tim has reiterated from time to time, if we can't reproduce the behavior reported by a user then we can only guess at causes.

Since moOde 9.0.3 was released today I flashed fresh images to a Pi Zero 2W and a Pi 3 A+ and tested the Bluetooth, Spotify, and Airplay renderers on all three. Both Pis are connected to my LAN via 2.4 GHz WiFi.

The audio output device: a Creative Labs USB-BT transceiver driving Sennheiser Bluetooth headphones.

The audio input device: an iPad mini running the Spotify app and streaming audio from Spotify servers. I don't hear stuttering using any of the three renderers on either Pi---in each case listening for at least 30 minute straight.

Of course absence of evidence is not necessarily evidence of absence but since I don't experience the problem I can't do any debugging here.

Good luck.

Regards,
Kent


RE: Airplay stuttering since moOde 9 - jammyb - 06-24-2024

Thanks Kent. In an effort to provide some further information, I've flashed moOde version 9.0.3 and provide some extra information below. The AirPlay stuttering is much less than I have experienced but is still occasionally present (only twice, in quick succession, in the last 20 minutes of playback). I'd say it's usable at the moment, and perhaps an adjustment to the Buffer Length will resolve it fully. 

journalctl -f
Code:
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:48 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:48 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:54 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:54 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1152 bytes from channel 2 failed: -5
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:27 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:27 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:34 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:34 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:35 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:35 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:55 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:55 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:03 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:03 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:23 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:23 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:24 moode kernel: mmc1: Got command interrupt 0x00000001 even though no command operation was in progress.
Jun 24 20:52:26 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:26 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:42 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:42 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10240 bytes failed: -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:52:59 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:59 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:19 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:19 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 8192 bytes failed: -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4096 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:51 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:51 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4608 bytes failed: -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:17 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:17 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1126 bytes from channel 2 failed: -5
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_readframes: brcmf_sdio_readframes: glom superframe w/o descriptor!
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1090 bytes from channel 2 failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:44 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:44 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:52 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:53 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1216 bytes from channel 2 failed: -5
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:08 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:21 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1202 bytes from channel 2 failed: -5
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:31 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:31 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1236 bytes from channel 2 failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:56:15 moode systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Jun 24 20:56:15 moode systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Jun 24 20:56:15 moode systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Jun 24 20:56:15 moode systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.53' (uid=0 pid=2874 comm="timedatectl")
Jun 24 20:56:25 moode systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 24 20:56:25 moode systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 24 20:56:55 moode systemd[1]: systemd-timedated.service: Deactivated successfully.

/var/log/moode_shairport-sync.log
Code:
0.076223646 "shairport.c:2278" Startup in AirPlay 2 mode, with features 0x405fca00,0x1c340 on device "e4:5f:01:5c:30:25".
        0.000331979 "shairport.c:2317" Version String: "4.3.3-AirPlay2-smi10-libdaemon-OpenSSL-Avahi-ALSA-jack-pa-dummy-stdout-pipe-soxr-convolution-metadata-mqtt-dbus-mpris-sysconfdir:/etc"
        0.000045417 "shairport.c:2336" Command Line: "/usr/bin/shairport-sync -v -a Moode AirPlay -- -d _audioout".
        0.000636146 "shairport.c:2372" Log Verbosity is 1.
        0.000052031 "audio_alsa.c:1022" alsa: alsa_maximum_stall_time of 0.200000 sec.
        0.000111406 "audio_alsa.c:1176" alsa output rate is 44100 frames per second
        0.000049271 "audio_alsa.c:1311" alsa: disable_standby_mode is "auto".
        0.000020208 "audio_alsa.c:1315" alsa: disable_standby_mode_silence_threshold is 0.040000 seconds.
        0.000024167 "audio_alsa.c:1317" alsa: disable_standby_mode_silence_scan_interval is 0.004000 seconds.
        0.000024739 "audio_alsa.c:1357" alsa: output device name is "_audioout".
        0.000566511 "shairport.c:2440" disable_resend_requests is off.
        0.000067917 "shairport.c:2441" diagnostic_drop_packet_fraction is 0.000000. A value of 0.0 means no packets will be dropped deliberately.
        0.000036406 "shairport.c:2445" statistics_requester status is 0.
        0.000028750 "shairport.c:2447" daemon status is 0.
        0.000028125 "shairport.c:1567" PID file: "/run/shairport-sync/shairport-sync.pid".
        0.000021562 "shairport.c:2448" daemon pid file path is "/run/shairport-sync/shairport-sync.pid".
        0.000024532 "shairport.c:2450" rtsp listening port is 7000.
        0.000018020 "shairport.c:2451" udp base port is 6001.
        0.000020834 "shairport.c:2452" udp port range is 10.
        0.000017031 "shairport.c:2453" player name is "Moode AirPlay".
        0.000017396 "shairport.c:2454" backend is "alsa".
        0.000020364 "shairport.c:2455" run_this_before_play_begins action is "(null)".
        0.000015886 "shairport.c:2456" run_this_after_play_ends action is "(null)".
        0.000016927 "shairport.c:2457" wait-cmd status is 1.
        0.000021094 "shairport.c:2458" run_this_before_play_begins may return output is 0.
        0.000022083 "shairport.c:2459" run_this_if_an_unfixable_error_is_detected action is "(null)".
        0.000015885 "shairport.c:2461" run_this_before_entering_active_state action is  "/var/local/www/commandw/spspre.sh".
        0.000020573 "shairport.c:2463" run_this_after_exiting_active_state action is  "/var/local/www/commandw/spspost.sh".
        0.000021927 "shairport.c:2465" active_state_timeout is  10.000000 seconds.
        0.000031355 "shairport.c:2466" mdns backend "(null)".
        0.000017031 "shairport.c:2468" interpolation setting is "soxr".
        0.000016719 "shairport.c:2472" interpolation soxr_delay_threshold is 30000000.
        0.000019010 "shairport.c:2473" resync time is 0.050000 seconds.
        0.000017396 "shairport.c:2474" resync recovery time is 0.100000 seconds.
        0.000020416 "shairport.c:2475" allow a session to be interrupted: 0.
        0.000017865 "shairport.c:2476" busy timeout time is 120.
        0.000021979 "shairport.c:2477" drift tolerance is 0.002000 seconds.
        0.000019011 "shairport.c:2478" password is not set.
        0.000020625 "shairport.c:2479" default airplay volume is: -24.000000.
        0.000019375 "shairport.c:2480" high threshold airplay volume is: -16.000000.
        0.000025104 "shairport.c:2482" check for higher-than-threshold volume for new play session is disabled.
        0.000016250 "shairport.c:2488" ignore_volume_control is 0.
        0.000018229 "shairport.c:2492" volume_max_db is not set
        0.000019792 "shairport.c:2493" volume range in dB (zero means use the range specified by the mixer): 0.
        0.000017500 "shairport.c:2495" volume_range_combined_hardware_priority (1 means hardware mixer attenuation is used first) is 0.
        0.000020052 "shairport.c:2499" playback_mode is 0 (0-stereo, 1-mono, 1-reverse_stereo, 2-both_left, 3-both_right).
        0.000081093 "shairport.c:2501" disable_synchronization is 0.
        0.000022396 "shairport.c:2502" use_mmap_if_available is 1.
        0.000017709 "shairport.c:2503" output_format automatic selection is disabled.
        0.000018385 "shairport.c:2506" output_format is "S16".
        0.000021146 "shairport.c:2507" output_rate automatic selection is disabled.
        0.000016875 "shairport.c:2510" output_rate is 44100.
        0.000016354 "shairport.c:2511" audio backend desired buffer length is 0.200000 seconds.
        0.000021615 "shairport.c:2513" audio_backend_buffer_interpolation_threshold_in_seconds is 0.120000 seconds.
        0.000018698 "shairport.c:2515" audio backend latency offset is 0.000000 seconds.
        0.000023906 "shairport.c:2517" audio backend silence lead-in time is "auto".
        0.000017187 "shairport.c:2521" zeroconf regtype is "_raop._tcp".
        0.000019948 "shairport.c:2522" decoders_supported field is 1.
        0.000014896 "shairport.c:2523" use_apple_decoder is 0.
        0.000016510 "shairport.c:2524" alsa_use_hardware_mute is 0.
        0.000016198 "shairport.c:2528" no special mdns service interface was requested.
        0.000075209 "shairport.c:2531" configuration file name "/etc/shairport-sync.conf" resolves to "/etc/shairport-sync.conf".
        0.000027343 "shairport.c:2538" metadata enabled is 1.
        0.000023907 "shairport.c:2539" metadata pipename is "/tmp/shairport-sync-metadata".
        0.000024166 "shairport.c:2540" metadata socket address is "(null)" port 0.
        0.000026042 "shairport.c:2542" metadata socket packet size is "500".
        0.000019948 "shairport.c:2543" get-coverart is 1.
        0.000021042 "shairport.c:2546" mqtt is disabled.
        0.000017187 "shairport.c:2547" mqtt hostname is (null), port is 1883.
        0.000018542 "shairport.c:2548" mqtt topic is /Moode AirPlay.
        0.000020312 "shairport.c:2549" mqtt will not publish raw metadata.
        0.000017396 "shairport.c:2550" mqtt will not publish parsed metadata.
        0.000017031 "shairport.c:2551" mqtt will not publish cover Art.
        0.000019584 "shairport.c:2552" mqtt remote control is disabled.
        0.000017291 "shairport.c:2556" convolution is 0.
        0.000018698 "shairport.c:2557" convolution IR file is "(null)"
        0.000018282 "shairport.c:2558" convolution max length 8192
        0.000019114 "shairport.c:2559" convolution gain is 0.000000
        0.000019844 "shairport.c:2561" loudness is 0.
        0.000018333 "shairport.c:2562" loudness reference level is -20.000000
        0.011605209 "rtsp.c:4235" metadata pipe name is "/tmp/shairport-sync-metadata".
        0.008610729 "shairport.c:2689" NQPTP is online.
        0.025032708 "dbus-service.c:610" >> setting loudness threshold to -20.000000.
        0.000324688 "dbus-service.c:623" >> setting drift tolerance to 0.002000 seconds.
        0.002285885 "dbus-service.c:1025" >> ALACDecoder set to "hammerton"
        0.000221250 "dbus-service.c:1030" >> Active set to "false"
        0.000181094 "dbus-service.c:1043" >> disable standby mode set to "auto"
        0.000068593 "dbus-service.c:1059" >> interpolation set to "soxr"
        0.000075313 "dbus-service.c:518" >> deactivating disable standby
        0.000061302 "dbus-service.c:600" >> deactivating loudness
        0.000048333 "dbus-service.c:534" >> deactivating convolution
        0.000220521 "dbus-service.c:503" >> log verbosity set to 1.
        0.000058281 "dbus-service.c:488" >> stop logging statistics
        0.000047709 "dbus-service.c:448" >> stop including elapsed time in logs
        0.000054166 "dbus-service.c:458" >> start including delta time in logs
        0.000049063 "dbus-service.c:471" >> start including file and line in logs
        0.000141510 "dbus-service.c:1175" Shairport Sync native D-Bus service started at "org.gnome.ShairportSync" on the system bus.
        0.004062188 "mpris-service.c:342" MPRIS service started at "org.mpris.MediaPlayer2.ShairportSync" on the system bus.
       90.482434392 "rtsp.c:2943" Connection 1: AP2 PTP connection from 2a0a:ef40:c8c:9f01:a081:af5e:26f:28df:49978 ("MacBook") to self at 2a0a:ef40:c8c:9f01:2316:80ef:aa0c:d3d7:7000.
       10.789744684 "rtsp.c:3334" Connection 1. AP2 Realtime Audio Stream.
Event: Run spspre.sh
        1.566717499 "rtp.c:1738" AP2 Realtime Clock receiver initialised.
      405.439664377 "player.c:2905" Large negative (i.e. early) sync error of -5544 frames (-0.125714 seconds), at frame: 2771798051.
Event: Run spspost.sh
      500.231600694 "rtsp.c:3334" Connection 1. AP2 Realtime Audio Stream.
Event: Run spspre.sh



RE: Airplay stuttering since moOde 9 - TheOldPresbyope - 06-24-2024

(06-24-2024, 08:12 PM)jammyb Wrote: Thanks Kent. In an effort to provide some further information, I've flashed moOde version 9.0.3 and provide some extra information below. The AirPlay stuttering is much less than I have experienced but is still occasionally present (only twice, in quick succession, in the last 20 minutes of playback). I'd say it's usable at the moment, and perhaps an adjustment to the Buffer Length will resolve it fully. 

journalctl -f
Code:
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:48 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:48 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:54 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:54 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1152 bytes from channel 2 failed: -5
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:27 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:27 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:34 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:34 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:35 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:35 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:55 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:55 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:03 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:03 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:23 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:23 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:24 moode kernel: mmc1: Got command interrupt 0x00000001 even though no command operation was in progress.
Jun 24 20:52:26 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:26 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:42 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:42 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10240 bytes failed: -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:52:59 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:59 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:19 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:19 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 8192 bytes failed: -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4096 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:51 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:51 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4608 bytes failed: -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:17 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:17 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1126 bytes from channel 2 failed: -5
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_readframes: brcmf_sdio_readframes: glom superframe w/o descriptor!
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1090 bytes from channel 2 failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:44 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:44 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:52 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:53 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1216 bytes from channel 2 failed: -5
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:08 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:21 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1202 bytes from channel 2 failed: -5
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:31 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:31 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1236 bytes from channel 2 failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:56:15 moode systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Jun 24 20:56:15 moode systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Jun 24 20:56:15 moode systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Jun 24 20:56:15 moode systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.53' (uid=0 pid=2874 comm="timedatectl")
Jun 24 20:56:25 moode systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 24 20:56:25 moode systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 24 20:56:55 moode systemd[1]: systemd-timedated.service: Deactivated successfully.

...

Ugh. AFAIK these brcmf messages are totally abnormal. They are error messages from the proprietary BroadCom firmware and/or driver. I've never seen them on any moOde installation. Maybe some searching of the InterWeb™ will enlighten me but at this point I have no idea what's happening.

Regards,
Kent


RE: Airplay stuttering since moOde 9 - jammyb - 06-25-2024

AirPlay stuttering is back up to once every few minutes at the moment (tried Buffer Length at default and at 0.5) so I'll flash moOde 8.3.9 and monitor this thread for any further progress. Thanks again, Kent.


RE: Airplay stuttering since moOde 9 - cramcram - 07-05-2024

(06-24-2024, 08:12 PM)jammyb Wrote: Thanks Kent. In an effort to provide some further information, I've flashed moOde version 9.0.3 and provide some extra information below. The AirPlay stuttering is much less than I have experienced but is still occasionally present (only twice, in quick succession, in the last 20 minutes of playback). I'd say it's usable at the moment, and perhaps an adjustment to the Buffer Length will resolve it fully. 

journalctl -f
Code:
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:50:18 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:50:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:48 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:48 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:48 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:50:54 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:50:54 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:50:54 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:20 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:51:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1152 bytes from channel 2 failed: -5
Jun 24 20:51:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:27 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:27 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:51:27 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:34 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:34 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:34 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:35 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:35 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:51:35 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:51:55 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:51:55 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:51:55 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:03 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:03 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:52:03 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:23 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:23 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10752 bytes failed: -5
Jun 24 20:52:23 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:24 moode kernel: mmc1: Got command interrupt 0x00000001 even though no command operation was in progress.
Jun 24 20:52:26 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:26 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:52:26 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:42 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:42 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 10240 bytes failed: -5
Jun 24 20:52:42 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:52:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:52:59 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:52:59 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 2048 bytes failed: -5
Jun 24 20:52:59 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:19 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:19 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 8192 bytes failed: -5
Jun 24 20:53:19 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:53:41 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:41 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4096 bytes failed: -5
Jun 24 20:53:41 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:51 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:51 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 4608 bytes failed: -5
Jun 24 20:53:51 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:53:56 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:53:56 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:17 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:17 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:54:17 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:20 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1126 bytes from channel 2 failed: -5
Jun 24 20:54:20 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:22 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9216 bytes failed: -5
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_readframes: brcmf_sdio_readframes: glom superframe w/o descriptor!
Jun 24 20:54:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6144 bytes failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:28 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1090 bytes from channel 2 failed: -5
Jun 24 20:54:28 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:44 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:44 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7680 bytes failed: -5
Jun 24 20:54:44 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:52 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:54:52 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:54:53 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1216 bytes from channel 2 failed: -5
Jun 24 20:54:53 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:08 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 7168 bytes failed: -5
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:08 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:13 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:13 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 9728 bytes failed: -5
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:13 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:21 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:21 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 5632 bytes failed: -5
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_hdparse: HW header length too long
Jun 24 20:55:21 moode kernel: brcmfmac: brcmf_sdio_rxfail: terminate frame
Jun 24 20:55:22 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1202 bytes from channel 2 failed: -5
Jun 24 20:55:22 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:31 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:31 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 6656 bytes failed: -5
Jun 24 20:55:31 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: mmc_submit_one: CMD53 sg block read failed -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxglom: glom read of 3584 bytes failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:55:45 moode kernel: mmc1: Controller never released inhibit bit(s).
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_readframes: read 1236 bytes from channel 2 failed: -5
Jun 24 20:55:45 moode kernel: brcmfmac: brcmf_sdio_rxfail: abort command, terminate frame
Jun 24 20:56:15 moode systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Jun 24 20:56:15 moode systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Jun 24 20:56:15 moode systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Jun 24 20:56:15 moode systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.53' (uid=0 pid=2874 comm="timedatectl")
Jun 24 20:56:25 moode systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 24 20:56:25 moode dbus-daemon[346]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 24 20:56:25 moode systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 24 20:56:55 moode systemd[1]: systemd-timedated.service: Deactivated successfully.

/var/log/moode_shairport-sync.log
Code:
0.076223646 "shairport.c:2278" Startup in AirPlay 2 mode, with features 0x405fca00,0x1c340 on device "e4:5f:01:5c:30:25".
        0.000331979 "shairport.c:2317" Version String: "4.3.3-AirPlay2-smi10-libdaemon-OpenSSL-Avahi-ALSA-jack-pa-dummy-stdout-pipe-soxr-convolution-metadata-mqtt-dbus-mpris-sysconfdir:/etc"
        0.000045417 "shairport.c:2336" Command Line: "/usr/bin/shairport-sync -v -a Moode AirPlay -- -d _audioout".
        0.000636146 "shairport.c:2372" Log Verbosity is 1.
        0.000052031 "audio_alsa.c:1022" alsa: alsa_maximum_stall_time of 0.200000 sec.
        0.000111406 "audio_alsa.c:1176" alsa output rate is 44100 frames per second
        0.000049271 "audio_alsa.c:1311" alsa: disable_standby_mode is "auto".
        0.000020208 "audio_alsa.c:1315" alsa: disable_standby_mode_silence_threshold is 0.040000 seconds.
        0.000024167 "audio_alsa.c:1317" alsa: disable_standby_mode_silence_scan_interval is 0.004000 seconds.
        0.000024739 "audio_alsa.c:1357" alsa: output device name is "_audioout".
        0.000566511 "shairport.c:2440" disable_resend_requests is off.
        0.000067917 "shairport.c:2441" diagnostic_drop_packet_fraction is 0.000000. A value of 0.0 means no packets will be dropped deliberately.
        0.000036406 "shairport.c:2445" statistics_requester status is 0.
        0.000028750 "shairport.c:2447" daemon status is 0.
        0.000028125 "shairport.c:1567" PID file: "/run/shairport-sync/shairport-sync.pid".
        0.000021562 "shairport.c:2448" daemon pid file path is "/run/shairport-sync/shairport-sync.pid".
        0.000024532 "shairport.c:2450" rtsp listening port is 7000.
        0.000018020 "shairport.c:2451" udp base port is 6001.
        0.000020834 "shairport.c:2452" udp port range is 10.
        0.000017031 "shairport.c:2453" player name is "Moode AirPlay".
        0.000017396 "shairport.c:2454" backend is "alsa".
        0.000020364 "shairport.c:2455" run_this_before_play_begins action is "(null)".
        0.000015886 "shairport.c:2456" run_this_after_play_ends action is "(null)".
        0.000016927 "shairport.c:2457" wait-cmd status is 1.
        0.000021094 "shairport.c:2458" run_this_before_play_begins may return output is 0.
        0.000022083 "shairport.c:2459" run_this_if_an_unfixable_error_is_detected action is "(null)".
        0.000015885 "shairport.c:2461" run_this_before_entering_active_state action is  "/var/local/www/commandw/spspre.sh".
        0.000020573 "shairport.c:2463" run_this_after_exiting_active_state action is  "/var/local/www/commandw/spspost.sh".
        0.000021927 "shairport.c:2465" active_state_timeout is  10.000000 seconds.
        0.000031355 "shairport.c:2466" mdns backend "(null)".
        0.000017031 "shairport.c:2468" interpolation setting is "soxr".
        0.000016719 "shairport.c:2472" interpolation soxr_delay_threshold is 30000000.
        0.000019010 "shairport.c:2473" resync time is 0.050000 seconds.
        0.000017396 "shairport.c:2474" resync recovery time is 0.100000 seconds.
        0.000020416 "shairport.c:2475" allow a session to be interrupted: 0.
        0.000017865 "shairport.c:2476" busy timeout time is 120.
        0.000021979 "shairport.c:2477" drift tolerance is 0.002000 seconds.
        0.000019011 "shairport.c:2478" password is not set.
        0.000020625 "shairport.c:2479" default airplay volume is: -24.000000.
        0.000019375 "shairport.c:2480" high threshold airplay volume is: -16.000000.
        0.000025104 "shairport.c:2482" check for higher-than-threshold volume for new play session is disabled.
        0.000016250 "shairport.c:2488" ignore_volume_control is 0.
        0.000018229 "shairport.c:2492" volume_max_db is not set
        0.000019792 "shairport.c:2493" volume range in dB (zero means use the range specified by the mixer): 0.
        0.000017500 "shairport.c:2495" volume_range_combined_hardware_priority (1 means hardware mixer attenuation is used first) is 0.
        0.000020052 "shairport.c:2499" playback_mode is 0 (0-stereo, 1-mono, 1-reverse_stereo, 2-both_left, 3-both_right).
        0.000081093 "shairport.c:2501" disable_synchronization is 0.
        0.000022396 "shairport.c:2502" use_mmap_if_available is 1.
        0.000017709 "shairport.c:2503" output_format automatic selection is disabled.
        0.000018385 "shairport.c:2506" output_format is "S16".
        0.000021146 "shairport.c:2507" output_rate automatic selection is disabled.
        0.000016875 "shairport.c:2510" output_rate is 44100.
        0.000016354 "shairport.c:2511" audio backend desired buffer length is 0.200000 seconds.
        0.000021615 "shairport.c:2513" audio_backend_buffer_interpolation_threshold_in_seconds is 0.120000 seconds.
        0.000018698 "shairport.c:2515" audio backend latency offset is 0.000000 seconds.
        0.000023906 "shairport.c:2517" audio backend silence lead-in time is "auto".
        0.000017187 "shairport.c:2521" zeroconf regtype is "_raop._tcp".
        0.000019948 "shairport.c:2522" decoders_supported field is 1.
        0.000014896 "shairport.c:2523" use_apple_decoder is 0.
        0.000016510 "shairport.c:2524" alsa_use_hardware_mute is 0.
        0.000016198 "shairport.c:2528" no special mdns service interface was requested.
        0.000075209 "shairport.c:2531" configuration file name "/etc/shairport-sync.conf" resolves to "/etc/shairport-sync.conf".
        0.000027343 "shairport.c:2538" metadata enabled is 1.
        0.000023907 "shairport.c:2539" metadata pipename is "/tmp/shairport-sync-metadata".
        0.000024166 "shairport.c:2540" metadata socket address is "(null)" port 0.
        0.000026042 "shairport.c:2542" metadata socket packet size is "500".
        0.000019948 "shairport.c:2543" get-coverart is 1.
        0.000021042 "shairport.c:2546" mqtt is disabled.
        0.000017187 "shairport.c:2547" mqtt hostname is (null), port is 1883.
        0.000018542 "shairport.c:2548" mqtt topic is /Moode AirPlay.
        0.000020312 "shairport.c:2549" mqtt will not publish raw metadata.
        0.000017396 "shairport.c:2550" mqtt will not publish parsed metadata.
        0.000017031 "shairport.c:2551" mqtt will not publish cover Art.
        0.000019584 "shairport.c:2552" mqtt remote control is disabled.
        0.000017291 "shairport.c:2556" convolution is 0.
        0.000018698 "shairport.c:2557" convolution IR file is "(null)"
        0.000018282 "shairport.c:2558" convolution max length 8192
        0.000019114 "shairport.c:2559" convolution gain is 0.000000
        0.000019844 "shairport.c:2561" loudness is 0.
        0.000018333 "shairport.c:2562" loudness reference level is -20.000000
        0.011605209 "rtsp.c:4235" metadata pipe name is "/tmp/shairport-sync-metadata".
        0.008610729 "shairport.c:2689" NQPTP is online.
        0.025032708 "dbus-service.c:610" >> setting loudness threshold to -20.000000.
        0.000324688 "dbus-service.c:623" >> setting drift tolerance to 0.002000 seconds.
        0.002285885 "dbus-service.c:1025" >> ALACDecoder set to "hammerton"
        0.000221250 "dbus-service.c:1030" >> Active set to "false"
        0.000181094 "dbus-service.c:1043" >> disable standby mode set to "auto"
        0.000068593 "dbus-service.c:1059" >> interpolation set to "soxr"
        0.000075313 "dbus-service.c:518" >> deactivating disable standby
        0.000061302 "dbus-service.c:600" >> deactivating loudness
        0.000048333 "dbus-service.c:534" >> deactivating convolution
        0.000220521 "dbus-service.c:503" >> log verbosity set to 1.
        0.000058281 "dbus-service.c:488" >> stop logging statistics
        0.000047709 "dbus-service.c:448" >> stop including elapsed time in logs
        0.000054166 "dbus-service.c:458" >> start including delta time in logs
        0.000049063 "dbus-service.c:471" >> start including file and line in logs
        0.000141510 "dbus-service.c:1175" Shairport Sync native D-Bus service started at "org.gnome.ShairportSync" on the system bus.
        0.004062188 "mpris-service.c:342" MPRIS service started at "org.mpris.MediaPlayer2.ShairportSync" on the system bus.
       90.482434392 "rtsp.c:2943" Connection 1: AP2 PTP connection from 2a0a:ef40:c8c:9f01:a081:af5e:26f:28df:49978 ("MacBook") to self at 2a0a:ef40:c8c:9f01:2316:80ef:aa0c:d3d7:7000.
       10.789744684 "rtsp.c:3334" Connection 1. AP2 Realtime Audio Stream.
Event: Run spspre.sh
        1.566717499 "rtp.c:1738" AP2 Realtime Clock receiver initialised.
      405.439664377 "player.c:2905" Large negative (i.e. early) sync error of -5544 frames (-0.125714 seconds), at frame: 2771798051.
Event: Run spspost.sh
      500.231600694 "rtsp.c:3334" Connection 1. AP2 Realtime Audio Stream.
Event: Run spspre.sh

Interesting. I had very similar error messages (brcmfmac: brcmf_sdio_rxfail and mmc1 errors) but on another Raspberry PI type (3B+). See post #26 on this thread.


RE: Airplay stuttering since moOde 9 - svitalya - 09-25-2024

(06-25-2024, 01:11 PM)jammyb Wrote: AirPlay stuttering is back up to once every few minutes at the moment (tried Buffer Length at default and at 0.5) so I'll flash moOde 8.3.9 and monitor this thread for any further progress. Thanks again, Kent.

Hello!

Did you solve this problem? I have the same issue with versions 9.x. The previous version worked fine, but there were problems with a sudden stop in music playback.

Thanks!


RE: Airplay stuttering since moOde 9 - philrandal - 09-25-2024

"mmc1: Controller never released inhibit bit(s)."

On the Pi Forums, https://forums.raspberrypi.com/viewtopic.php?t=330384

RPI4: mmc1: Timeout when WiFi interface is under heavy load
https://github.com/raspberrypi/linux/issues/4161


RE: Airplay stuttering since moOde 9 - Tim Curtis - 09-25-2024

(09-25-2024, 06:01 PM)philrandal Wrote: "mmc1: Controller never released inhibit bit(s)."

On the Pi Forums, https://forums.raspberrypi.com/viewtopic.php?t=330384

RPI4: mmc1: Timeout when WiFi interface is under heavy load
https://github.com/raspberrypi/linux/issues/4161

Does the mmc1 message imply the Pi is booting from something other than an uSD card for example an onboard eMMC module or a USB drive?


RE: Airplay stuttering since moOde 9 - cramcram - 10-16-2024

(09-25-2024, 08:35 PM)Tim Curtis Wrote:
(09-25-2024, 06:01 PM)philrandal Wrote: "mmc1: Controller never released inhibit bit(s)."

On the Pi Forums, https://forums.raspberrypi.com/viewtopic.php?t=330384

RPI4: mmc1: Timeout when WiFi interface is under heavy load
https://github.com/raspberrypi/linux/issues/4161

Does the mmc1 message imply the Pi is booting from something other than an uSD card for example an onboard eMMC module or a USB drive?

Not for me. I'm booting from an SD Card.


RE: Airplay stuttering since moOde 9 - Always_In_The_Moode - 10-16-2024

(10-16-2024, 08:33 AM)cramcram Wrote:
(09-25-2024, 08:35 PM)Tim Curtis Wrote:
(09-25-2024, 06:01 PM)philrandal Wrote: "mmc1: Controller never released inhibit bit(s)."

On the Pi Forums, https://forums.raspberrypi.com/viewtopic.php?t=330384

RPI4: mmc1: Timeout when WiFi interface is under heavy load
https://github.com/raspberrypi/linux/issues/4161

Does the mmc1 message imply the Pi is booting from something other than an uSD card for example an onboard eMMC module or a USB drive?

Not for me. I'm booting from an SD Card.

I remember seeing these errors on a Raspberry Pi 4 I was using before, it turned out to be a failing SD card. All was well again once I replaced it.