That is indeed helpful. If you can get console access via ssh, can you try running commands from some posts up?
Thanks for getting back to me. With volumio stopped and the service restarted the issue persisted.
Here is the log.
volumio@kanne-hifi:~$ volumio vstop
volumio@kanne-hifi:~$ systemctl restart volspotconnect2 && journalctl -f
-- Logs begin at Mon 2021-02-01 12:22:10 UTC. --
Feb 01 15:12:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:18] [error] handle_connect error: Underlying Transport Error
Feb 01 15:12:26 kanne-hifi sudo[25516]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2
Feb 01 15:12:26 kanne-hifi sudo[25516]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Feb 01 15:12:26 kanne-hifi systemd[1]: Stopping Volspotconnect2 Daemon...
Feb 01 15:12:26 kanne-hifi systemd[1]: Starting Volspotconnect2 Daemon...
Feb 01 15:12:26 kanne-hifi systemd[1]: Started Volspotconnect2 Daemon.
Feb 01 15:12:26 kanne-hifi sudo[25516]: pam_unix(sudo:session): session closed for user root
Feb 01 15:12:26 kanne-hifi volumio[25523]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Feb 01 15:12:26 kanne-hifi volumio[25523]: Reading Config from "volspotify.toml"
Feb 01 15:12:26 kanne-hifi volumio[25523]: [Vollibrespot] : Using Alsa backend with device: softvolume
Feb 01 15:12:26 kanne-hifi volumio[25523]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
Feb 01 15:12:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:28] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:12:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:12:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:28] [error] handle_connect error: Underlying Transport Error
Feb 01 15:12:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:38] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:12:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:12:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:38] [error] handle_connect error: Underlying Transport Error
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Connecting to AP "gew1-accesspoint-e-272b.ap.spotify.com:443"
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Authenticated as "seelenente" !
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Setting up new mixer: card:hw:2 mixer:SoftMaster index:0
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Alsa Mixer info min: 0 (MilliBel(0)[dB]) -- max: 99 (MilliBel(0)[dB]) HW: false
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Using Alsa linear volume
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Using alsa sink
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Metadata pipe established
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Country: "DE"
Feb 01 15:12:41 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 0 }
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Fetching autoplay context uri
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Event: SessionActive { became_active_at: 1612192362135 }
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : SessionActive!
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 56997054916516033435083919883111801149, audio_type: Track } }
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 56997054916516033435083919883111801149, audio_type: Track } }
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : No autoplay_uri found
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : AutoplayError: MercuryError
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Loading <i'm gonna tell my therapist on you> with Spotify URI <spotify:track:1iUBNLLmZnBAjgkHysEv37>
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQA8kPd1HbNBEc_6BtbabeaClZHuvt3mjwRoEtLKtVxU5uisD5t1UXHM6eNQXQcLNshGGm8hrOEJ0zKxKWxUNO3gZYrvC7NmW9omUbEJ4LOI2WFJdmE-KQ_ZOgEvfqA9Yg1hyIJpPcTuB5OtunxeJLDnSOgSkn3t7uir4w", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : <i'm gonna tell my therapist on you> (161062 ms) loaded
Feb 01 15:12:42 kanne-hifi volumio[25523]: [Vollibrespot] : Event: SinkActive
Feb 01 15:12:46 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 5120 }
Feb 01 15:12:46 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 10240 }
Feb 01 15:12:47 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 11264 }
Feb 01 15:12:47 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 14336 }
Feb 01 15:12:48 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 22528 }
Feb 01 15:12:48 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 26624 }
Feb 01 15:12:48 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 30720 }
Feb 01 15:12:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:48] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:12:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:12:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:48] [error] handle_connect error: Underlying Transport Error
Feb 01 15:12:48 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 33792 }
Feb 01 15:12:49 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 36864 }
Feb 01 15:12:50 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 40960 }
Feb 01 15:12:50 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 45056 }
Feb 01 15:12:50 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 53248 }
Feb 01 15:12:51 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 61440 }
Feb 01 15:12:51 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 }
Feb 01 15:12:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:58] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:12:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:12:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:12:58] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:08] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:08] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:18] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:18] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:28] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:28] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:37 kanne-hifi volumio[25523]: [Vollibrespot] : Loading <On Thin Ice> with Spotify URI <spotify:track:6hzalkXXhxxvEFY0gXj8ZV>
Feb 01 15:13:38 kanne-hifi volumio[25523]: [Vollibrespot] : <On Thin Ice> (169000 ms) loaded
Feb 01 15:13:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:38] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:38] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:48] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:48] [error] handle_connect error: Underlying Transport Error
Feb 01 15:13:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:58] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:13:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:13:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:13:58] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:07 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Next { track_id: SpotifyId { id: 274420266519309217704190408551723116599, audio_type: Track } }
Feb 01 15:14:07 kanne-hifi volumio[25523]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 56997054916516033435083919883111801149, audio_type: Track }, track_id: SpotifyId { id: 274420266519309217704190408551723116599, audio_type: Track } }
Feb 01 15:14:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:08] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:08] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:18] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:18] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:28] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:28] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:38] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:38] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:48] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:48] [error] handle_connect error: Underlying Transport Error
Feb 01 15:14:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:58] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:14:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:14:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:14:58] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:08] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:08] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:18] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:18] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:28] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:28] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:38] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:38] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:48] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:48] [error] handle_connect error: Underlying Transport Error
Feb 01 15:15:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:58] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:15:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:15:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:15:58] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:08] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:16:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:16:08 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:08] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:18] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:16:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:16:18 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:18] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:26 kanne-hifi volumio[25523]: [Vollibrespot] : Loading <Too Many Rappers> with Spotify URI <spotify:track:4XMQa78z5CsMrYfVYUfsda>
Feb 01 15:16:27 kanne-hifi volumio[25523]: [Vollibrespot] : <Too Many Rappers> (264440 ms) loaded
Feb 01 15:16:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:28] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:16:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:16:28 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:28] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:38] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:16:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:16:38 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:38] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:48] [info] asio async_connect error: system:111 (Connection refused)
Feb 01 15:16:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 01 15:16:48 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:48] [error] handle_connect error: Underlying Transport Error
Feb 01 15:16:52 kanne-hifi volumio[25523]: ALSA lib pcm.c:8306:(snd_pcm_recover) underrun occurred
Feb 01 15:16:56 kanne-hifi volumio[25523]: [Vollibrespot] : Event: Next { track_id: SpotifyId { id: 216812910752534324856258807855445060840, audio_type: Track } }
Feb 01 15:16:56 kanne-hifi volumio[25523]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 274420266519309217704190408551723116599, audio_type: Track }, track_id: SpotifyId { id: 216812910752534324856258807855445060840, audio_type: Track } }
Feb 01 15:16:58 kanne-hifi volumio-remote-updater[741]: [2021-02-01 15:16:58] [info] asio async_connect error: system:111 (Connection refused)Did I understand correctly that the issue occurs only after a few tracks? At least that is when the buffer under run shows up.
Either way, would you be willing to debug more? Could you grab a previous version of Vollibrespot and test with that? You could just download it into /data/plugins/music_service/volspotconnect2/. PS, pick the armhf version for you pi3…
Yes the issue usually starts at the second or third song for the first time and after that it is at least once or twice a song.
I’ve downgraded Vollibrespot and it seems to have worked. I did not hear any skipping and I captured about 1h 40m worth of live log which does not show the buffer underrun.
@rince Thank you for the confirmation. Apparently the Softmaster device doesn’t like an explicit period size being set. I will take a look when I find some time. 
Today I tried for the first time Spotify Connect with Volumio 3 and I am also experiencing this stuttering problem. It happens mostly on long tracks, but in general always on first tracks I play.
Here’s the problem as wrote on log:
Dec 19 15:08:21 volumio volumio[976]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
Dec 19 15:08:22 volumio volumio[976]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
Any help would be welcome.
Can you post full log(link to the log) after reboot and after the issue is occuring?
Thanks Joni,
I purposely chose to play a long track (1 hour and 14 minutes) on Spotify and the stuttering was continuous as you can see from the logs:
-- Logs begin at Sun 2021-12-19 15:21:03 UTC. --
Dec 19 15:22:20 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error!
Dec 19 15:22:20 volumio volumio[736]: info: CoreCommandRouter::volumioGetState
Dec 19 15:22:20 volumio volumio[736]: [SpotifyConnect] Currently active: undefin ed
Dec 19 15:22:20 volumio volumio[736]: [SpotifyConnect] Pushing new state :: true
Dec 19 15:22:20 volumio volumio[736]: info: CoreCommandRouter::servicePushState
Dec 19 15:22:20 volumio volumio[736]: info: CoreStateMachine::pushState
Dec 19 15:22:20 volumio volumio[736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 19 15:22:20 volumio volumio[736]: info: CoreCommandRouter::volumioPushState
Dec 19 15:22:20 volumio sudo[1112]: volumio : TTY=pts/0 ; PWD=/home/volumio ; U SER=root ; COMMAND=/bin/journalctl -f
Dec 19 15:22:20 volumio sudo[1112]: pam_unix(sudo:session): session opened for u ser root by volumio(uid=0)
Dec 19 15:22:21 volumio ntpd[641]: Soliciting pool server 85.21.78.23
Dec 19 15:22:21 volumio ntpd[641]: Soliciting pool server 93.94.88.51
Dec 19 15:22:21 volumio ntpd[641]: Soliciting pool server 220.158.215.21
Dec 19 15:22:22 volumio ntpd[641]: Soliciting pool server 85.10.240.253
Dec 19 15:22:22 volumio ntpd[641]: Soliciting pool server 2a00:1080:80d:201::d:1
Dec 19 15:22:22 volumio ntpd[641]: Soliciting pool server 178.17.161.12
Dec 19 15:22:23 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) unde rrun occurred
Dec 19 15:22:24 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurre d
Dec 19 15:22:53 volumio ntpd[641]: receive: Unexpected origin timestamp 0xe569ccb1.03e595bb does not match aorg 0000000000.00000000 from server@85.10.240.253 xmt 0xe569cccd.843b7e0a
Dec 19 15:22:53 volumio ntpd[641]: receive: Unexpected origin timestamp 0xe569ccb1.03df475b does not match aorg 0000000000.00000000 from server@178.17.161.12 xmt 0xe569cccd.94379553
Dec 19 15:22:53 volumio ntpd[641]: receive: Unexpected origin timestamp 0xe569ccb1.03e7dee7 does not match aorg 0000000000.00000000 from server@194.158.196.172 xmt 0xe569cccd.8b374932
Dec 19 15:22:53 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurre d
Dec 19 15:22:55 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurre d
Dec 19 15:23:03 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurre d
Dec 19 15:23:04 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurre d
Dec 19 15:23:19 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
Dec 19 15:23:20 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
Dec 19 15:23:27 volumio volumio[952]: ALSA lib pcm.c:8424:(snd_pcm_recover) underrun occurred
^C
The problem seems to be gone. I’ve done several tests since yesterday afternoon and it no longer occured.
I don’t know what caused the error though.
Reading here it seems to be a problem related to the size of the buffer. If it comes back I could try changing those values in damon.conf
What kind of internet connection you have? (3g/4g)
When it gets crowded perhaps there’s not enought bandwidth available.
VDSL2 connection, about 60 Mbps in download. Raspberry w Volumio is connected by cable.
I’ve never had any connection problems over the years (with Volumio 2).
Maybe yesterday there was some problem on the line, provider side, who knows.
I will monitor the situation in the next few days.
In the meantime, thanks for your interest Joni!