I recently replaced my Synology NAS with a Mac mini M4 and tried to use AO but the music regularly stops playing.
I have identified a particular track that always stops playing after a few seconds. This happens both with AO and the remote app connected to AO running on the Mac mini. The issue does NOT, however, occur with 3.5.50, so something in the UPnP/networking code must have changed between the 2 versions. The issue also does NOT occur when playing the track through mConnect HD on the iPad where the Audirvana remote app is installed.
The settings for both AO and 3.5.50 are the same and they are both authorised to access the Local Network. This is a fresh macOS 15.2 installation (upgraded from shipped 15.1). The macOS firewall is OFF.
The UPnP rendering device is a Devialet 140 Pro.
Here is an excerpt from the AO log. It looks like AO thinks the Devialet goes to sleep, but 3.5.50 and mConnect HD don’t seem to think so and indeed it does not.
2025-01-02 16:10:21.517 [debug]: UPnP Received AVTransportURI change to http://192.168.0.102:49152/audirvana/audio_f_63.wav
2025-01-02 16:10:21.523 [error]: Fatal error reading audio file file://%2FVolumes%2FNAS%2Fmusique%2FDivers%2FStan%20Getz%20%26%20Joa%CC%83o%20Gilberto%2FGetz_%20Getz-Gilberto%2F02%20Doralice.m4a aborting loading at frame 7332360
2025-01-02 16:10:21.541 [error]: UPnP: Error Subscribing to EventURL -- -204
2025-01-02 16:10:21.654 [debug]: UPnP getting volume scalar 49%
2025-01-02 16:10:21.678 [debug]: UPnP Received updated transport actions:Stop,Pause,Seek,X_DLNA_SeekTime
2025-01-02 16:10:21.678 [debug]: UPnP Received new transport state PLAYING
2025-01-02 16:10:21.736 [debug]: UPnP Exiting playing start polling loop with 48 attempts remaining
2025-01-02 16:10:21.867 [debug]: UPnP Send info for file audio_f_64.wav from buffer 1 trackId 64 title: Para Machuchar Meu Coração
2025-01-02 16:10:21.879 [debug]: UPnP Success setting NextAVTransportURI to http://192.168.0.102:49152/audirvana/audio_f_64.wav
2025-01-02 16:10:22.017 [debug]: UPnP received audio data request from 1048532 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.017 [debug]: UPnP sending audio from 0:5 playing 0:0 loaded to 2:46 from 1048532 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.118 [debug]: UPnP received audio data request from 2097108 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.118 [debug]: UPnP sending audio from 0:11 playing 0:0 loaded to 2:46 from 2097108 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.182 [debug]: UPnP received audio data request from 3145684 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.182 [debug]: UPnP sending audio from 0:17 playing 0:0 loaded to 2:46 from 3145684 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.213 [debug]: UPnP received audio data request from 4194260 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.213 [debug]: UPnP sending audio from 0:23 playing 0:0 loaded to 2:46 from 4194260 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.265 [debug]: UPnP received audio data request from 5242836 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.265 [debug]: UPnP sending audio from 0:29 playing 0:0 loaded to 2:46 from 5242836 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.412 [debug]: UPnP received audio data request from 6291412 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.412 [debug]: UPnP sending audio from 0:35 playing 0:0 loaded to 2:46 from 6291412 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.481 [debug]: UPnP received audio data request from 7339988 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.481 [debug]: UPnP sending audio from 0:41 playing 0:0 loaded to 2:46 from 7339988 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.552 [debug]: UPnP received audio data request from 8388564 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.552 [debug]: UPnP sending audio from 0:47 playing 0:0 loaded to 2:46 from 8388564 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.699 [debug]: UPnP received audio data request from 9437140 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.699 [debug]: UPnP sending audio from 0:53 playing 0:0 loaded to 2:46 from 9437140 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.824 [debug]: UPnP received audio data request from 10485716 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.824 [debug]: UPnP sending audio from 0:59 playing 0:0 loaded to 2:46 from 10485716 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.962 [debug]: UPnP received audio data request from 11534292 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:22.962 [debug]: UPnP sending audio from 1:5 playing 0:0 loaded to 2:46 from 11534292 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:23.104 [debug]: UPnP received audio data request from 12582868 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:23.104 [debug]: UPnP sending audio from 1:11 playing 0:0 loaded to 2:46 from 12582868 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.488 [debug]: UPnP received audio data request from 13631444 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.488 [debug]: UPnP sending audio from 1:17 playing 0:1 loaded to 2:46 from 13631444 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.728 [debug]: UPnP received audio data request from 14680020 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.728 [debug]: UPnP sending audio from 1:23 playing 0:1 loaded to 2:46 from 14680020 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.909 [debug]: UPnP received audio data request from 15728596 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:24.909 [debug]: UPnP sending audio from 1:29 playing 0:1 loaded to 2:46 from 15728596 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.081 [debug]: UPnP received audio data request from 16777172 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.082 [debug]: UPnP sending audio from 1:35 playing 0:1 loaded to 2:46 from 16777172 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.327 [debug]: UPnP received audio data request from 17825748 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.327 [debug]: UPnP sending audio from 1:41 playing 0:2 loaded to 2:46 from 17825748 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.498 [debug]: UPnP received audio data request from 18874324 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.498 [debug]: UPnP sending audio from 1:46 playing 0:2 loaded to 2:46 from 18874324 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.691 [debug]: UPnP received audio data request from 19922900 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.691 [debug]: UPnP sending audio from 1:52 playing 0:3 loaded to 2:46 from 19922900 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.852 [debug]: UPnP received audio data request from 20971476 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.852 [debug]: UPnP sending audio from 1:58 playing 0:3 loaded to 2:46 from 20971476 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.999 [debug]: UPnP received audio data request from 22020052 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:25.999 [debug]: UPnP sending audio from 2:4 playing 0:3 loaded to 2:46 from 22020052 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.145 [debug]: UPnP received audio data request from 23068628 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.146 [debug]: UPnP sending audio from 2:10 playing 0:3 loaded to 2:46 from 23068628 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.285 [debug]: UPnP received audio data request from 24117204 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.285 [debug]: UPnP sending audio from 2:16 playing 0:3 loaded to 2:46 from 24117204 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.451 [debug]: UPnP received audio data request from 25165780 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.451 [debug]: UPnP sending audio from 2:22 playing 0:3 loaded to 2:46 from 25165780 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.615 [debug]: UPnP received audio data request from 26214356 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.615 [debug]: UPnP sending audio from 2:28 playing 0:3 loaded to 2:46 from 26214356 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.748 [debug]: UPnP received audio data request from 27262932 for 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.748 [debug]: UPnP sending audio from 2:34 playing 0:3 loaded to 2:46 from 27262932 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.922 [debug]: UPnP received audio data request from 28311508 for 1017988 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:26.922 [debug]: UPnP sending audio from 2:40 playing 0:4 loaded to 2:46 from 28311508 for 1017932 requested 1017988 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.069 [debug]: UPnP received audio data request from 29329440 for 56 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.114 [debug]: UPnP Send info for file audio_f_63.wav from buffer 0 trackId 63 title: Doralice
2025-01-02 16:10:27.115 [debug]: UPnP open file /audirvana/audio_f_63.wav
2025-01-02 16:10:27.115 [debug]: UPnP webserver: seek 29329484 bytes from 1 from buffer 0
2025-01-02 16:10:27.115 [debug]: UPnP received audio data request from 29329440 for 56 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.131 [debug]: UPnP Send info for file audio_f_63.wav from buffer 0 trackId 63 title: Doralice
2025-01-02 16:10:27.131 [debug]: UPnP open file /audirvana/audio_f_63.wav
2025-01-02 16:10:27.131 [debug]: UPnP webserver: seek 29329484 bytes from 1 from buffer 0
2025-01-02 16:10:27.131 [debug]: UPnP received audio data request from 29329440 for 56 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.146 [debug]: UPnP Send info for file audio_f_63.wav from buffer 0 trackId 63 title: Doralice
2025-01-02 16:10:27.146 [debug]: UPnP open file /audirvana/audio_f_63.wav
2025-01-02 16:10:27.146 [debug]: UPnP webserver: seek 29329484 bytes from 1 from buffer 0
2025-01-02 16:10:27.146 [debug]: UPnP received audio data request from 29329440 for 56 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.161 [debug]: UPnP Send info for file audio_f_63.wav from buffer 0 trackId 63 title: Doralice
2025-01-02 16:10:27.161 [debug]: UPnP open file /audirvana/audio_f_63.wav
2025-01-02 16:10:27.161 [debug]: UPnP webserver: seek 29329484 bytes from 1 from buffer 0
2025-01-02 16:10:27.161 [debug]: UPnP received audio data request from 29329440 for 56 loaded 29329440 from buffer 0 trackId 63
2025-01-02 16:10:27.346 [error]: UPnP audio device unreachable (powered off ?), aborting playing position monitoring
2025-01-02 16:10:27.366 [error]: UPnP select device: can't find the device Devialet Expert 140 Pro with UID: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:29.758 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.067 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.372 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.373 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.679 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.681 [debug]: UPnP Received ByeBye for Device: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92
2025-01-02 16:10:30.699 [debug]: UPnP Device added UID: uuid:5b652592-88e6-4195-bf6b-5af24cf59c92 location: http://192.168.0.2:35983/5b652592-88e6-4195-bf6b-5af24cf59c92.xml manufacturer: Devialet friendly name: Devialet Expert Pro 140
2025-01-02 16:10:31.286 [error]: UPnP Error 401 getting audio dB volume
2025-01-02 16:10:31.338 [debug]: UPnP getting volume scalar 64%
2025-01-02 16:11:55.613 [debug]: UPnP Received AVTransportURI change to http://192.168.0.102:49152/audirvana/audioTest.pcm
2025-01-02 16:11:55.613 [debug]: UPnP AVTransportURI change notification DISCARDED as in starting phase
2025-01-02 16:11:55.613 [debug]: UPnP Received updated transport actions:Play,Seek,X_DLNA_SeekTime
2025-01-02 16:11:55.685 [debug]: UPnP setPlayingBuffer discarded
2025-01-02 16:11:55.695 [debug]: UPnP Received new transport state STOPPED
2025-01-02 16:11:55.717 [debug]: UPnP Received AVTransportURI change to http://192.168.0.102:49152/audirvana/audioTest.pcm
2025-01-02 16:11:55.717 [debug]: UPnP AVTransportURI change notification DISCARDED as in starting phase
2025-01-02 16:11:55.734 [debug]: UPnP Send info for file audio_f_65.wav from buffer 0 trackId 65 title: Doralice
2025-01-02 16:11:55.761 [debug]: UPnP Success setting AVTransportURI to http://192.168.0.102:49152/audirvana/audio_f_65.wav
2025-01-02 16:11:55.792 [debug]: UPnP send setNextAVTransportURI for track Para Machuchar Meu Coração
2025-01-02 16:11:55.995 [debug]: UPnP Send info for file audio_f_65.wav from buffer 0 trackId 65 title: Doralice
2025-01-02 16:11:55.995 [debug]: UPnP open file /audirvana/audio_f_65.wav
2025-01-02 16:11:55.995 [debug]: UPnP sent WAVE header with fileLength 29329540 audio data 29329496 from buffer 0 trackId 65
2025-01-02 16:11:55.995 [debug]: UPnP received audio data request from 0 for 1048532 loaded 26636400 from buffer 0 trackId 65
2025-01-02 16:11:55.995 [debug]: UPnP sending audio from 0:0 playing 0:0 loaded to 2:31 from 0 for 1048532 requested 1048532 loaded 26636400 from buffer 0 trackId 65
2025-01-02 16:11:56.017 [debug]: UPnP Received AVTransportURI change to http://192.168.0.102:49152/audirvana/audio_f_65.wav
2025-01-02 16:11:56.023 [error]: Fatal error reading audio file file://%2FVolumes%2FNAS%2Fmusique%2FDivers%2FStan%20Getz%20%26%20Joa%CC%83o%20Gilberto%2FGetz_%20Getz-Gilberto%2F02%20Doralice.m4a aborting loading at frame 7332360
2025-01-02 16:11:56.142 [debug]: UPnP Received updated transport actions:Stop,Pause,Seek,X_DLNA_SeekTime
2025-01-02 16:11:56.143 [debug]: UPnP Received new transport state PLAYING
2025-01-02 16:11:56.155 [debug]: UPnP getting volume scalar 49%
2025-01-02 16:11:56.201 [debug]: UPnP Exiting playing start polling loop with 48 attempts remaining
2025-01-02 16:11:56.342 [debug]: UPnP Send info for file audio_f_66.wav from buffer 1 trackId 66 title: Para Machuchar Meu Coração
2025-01-02 16:11:56.353 [debug]: UPnP Success setting NextAVTransportURI to http://192.168.0.102:49152/audirvana/audio_f_66.wav
2025-01-02 16:11:56.764 [debug]: UPnP received audio data request from 1048532 for 1048576 loaded 29329440 from buffer 0 trackId 65
2025-01-02 16:11:56.764 [debug]: UPnP sending audio from 0:5 playing 0:0 loaded to 2:46 from 1048532 for 1048576 requested 1048576 loaded 29329440 from buffer 0 trackId 65
2025-01-02 16:11:56.970 [debug]: UPnP received audio data request from 2097108 for 1048576 loaded 29329440 from buffer 0 trackId 65
2025-01-02 16:11:56.970 [debug]: UPnP sending audio from 0:11 playing