Radio station stops playing

**slartibartfast** · 2022-06-21, 03:42

The radio station Delicious Agony
http://www.deliciousagony.com/listen.pls
stops playing after a time when played on a Touch or a Radio. It doesn't stop when played on my mpd player via the upnp/DLNA bridge. It seems to stop directly after a station ID message. Proxied streaming doesn't help.
All thoughts welcome

Sent from my Pixel 3a using Tapatalk

**bpa** · 2022-06-21, 03:50

Originally Posted by slartibartfast

The radio station Delicious Agony
http://www.deliciousagony.com/listen.pls
stops playing after a time when played on a Touch or a Radio. It doesn't stop when played on my mpd player via the upnp/DLNA bridge. It seems to stop directly after a station ID message. Proxied streaming doesn't help.

First thoughts.
Although there are some icy headers - there is no icy-metaint which would allow for metadata to be inserted into the audio stream - so I think for an ID to be added mid stream is wrong.

I'll testing it using ffplay with logging to see what happens

**bpa** · 2022-06-21, 04:15

It looks like there is icy metadata within the stream and LMS seems to handle it OK - maybe there is a default icy-metaint setting as I think no icy-metaint is unusual. I think checking how metadata is encoded in the stream and what LMS expects is a starting point.

IIRC "icy" is not a documented technology except in source code and so variations occurs.

**slartibartfast** · 2022-06-21, 04:25

Originally Posted by bpa

It looks like there is icy metadata within the stream and LMS seems to handle it OK - maybe there is a default icy-metaint setting as I think no icy-metaint is unusual. I think checking how metadata is encoded in the stream and what LMS expects is a starting point.

IIRC "icy" is not a documented technology except in source code and so variations occurs.

Is there a logging setting in LMS I can set?
Does the fact that the DLNA mpd player on a Pi isn't affected give a clue?

Sent from my Pixel 3a using Tapatalk

**bpa** · 2022-06-21, 04:46

Originally Posted by slartibartfast

Is there a logging setting in LMS I can set?
Does the fact that the DLNA mpd player on a Pi isn't affected give a clue?

Sent from my Pixel 3a using Tapatalk

my bad- there is an icy-metaint set at 16000 - it just oddly placed as the very last header after "Expires" -

That said - I have had a break in playing and it was just after a icy metadata.

You can see when metadata is being parsed by logging formats.metadata to DEBUG and player.streaming.remote to DEBIG (not sure which is key).

**bpa** · 2022-06-21, 05:41

player.streaming.remote set to DEBUG will show the metadata parsing in remote streams

Code:

22-06-21 13:18:59.2236] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Helloween - Don't Run For Cover, from the 1985 album `Walls Of Jericho`';

Since there is silence - initial ideas (i) LMS stream processing has stopped or (ii) MP3 decoding has broken.

If player.streaming.remote logging is set to DEBUG then if stream is still "playing" - new metadata should keep appearing as long as stream is being played - this seems to be true for both direct and proxied.

If metadata keeps appearing but stream is silent then it would seem MP3 decode is at issue.
If metadata stops appearing - then it would appear that reading data from station has stopped.

**slartibartfast** · 2022-06-21, 06:47

Originally Posted by bpa

player.streaming.remote set to DEBUG will show the metadata parsing in remote streams

Code:

22-06-21 13:18:59.2236] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Helloween - Don't Run For Cover, from the 1985 album `Walls Of Jericho`';

Since there is silence - initial ideas (i) LMS stream processing has stopped or (ii) MP3 decoding has broken.

If player.streaming.remote logging is set to DEBUG then if stream is still "playing" - new metadata should keep appearing as long as stream is being played - this seems to be true for both direct and proxied.

If metadata keeps appearing but stream is silent then it would seem MP3 decode is at issue.
If metadata stops appearing - then it would appear that reading data from station has stopped.

The Radio Now Playing plugin retrieves metadata for the stream and this stops changing after playback stops. I'm just about to check the log.

Sent from my Pixel 3a using Tapatalk

**bpa** · 2022-06-21, 07:08

I had station playing with the plain URL http://deliciousagony.streamguys1.com/and it did not stop but I did not cross "top of the hour" boundary.

I then changed to the pls URL ( http://deliciousagony.streamguys1.com/ ) and it stopped quite quickly with below, note it crosses "top of the hour". Maybe coincidence or perhaps station ID plus "pls" has the issue as it maybe a new MP3 stream is inserted for announcement. LMS is looking for next stream entry in pls - and there is none.

Code:

[22-06-21 14:59:15.0408] Slim::Schema::RemoteTrack::setAttributes (366) title: http://www.deliciousagony.com/listen.pls=>Delicious Agony
[22-06-21 14:59:15.0410] Slim::Schema::RemoteTrack::setAttributes (366) titlesearch: HTTP WWW DELICIOUSAGONY COM LISTEN PLS=>DELICIOUS AGONY
[22-06-21 14:59:15.0412] Slim::Schema::RemoteTrack::setAttributes (366) titlesort: HTTP WWW DELICIOUSAGONY COM LISTEN PLS=>DELICIOUS AGONY
[22-06-21 14:59:15.0417] Slim::Schema::RemotePlaylist::getNextEntry (57) Considering http://deliciousagony.streamguys1.com/ (type: mp3)
[22-06-21 14:59:15.0419] Slim::Schema::RemotePlaylist::getNextEntry (74) Next playlist entry is http://deliciousagony.streamguys1.com/
[22-06-21 14:59:15.0466] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 48 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 14:59:15.7669] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 14:59:15.7678] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  CONTENT_TYPE => "mp3",
  RATING => 0,
  REMOTE => 1,
  YEAR => 0,
  urlmd5 => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 14:59:16.0481] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='The Pineapple Thief - Out Of Line, from the 2021 album `Nothing But The Truth`';
[22-06-21 14:59:16.4739] Slim::Schema::RemoteTrack::get (431) http://deliciousagony.streamguys1.com/, title->Delicious Agony
[22-06-21 15:00:38.6738] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Delicious Agony - Delicious Agony ID #7';
[22-06-21 15:01:02.9790] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Delicious Agony - The Golden Age Intro';
[22-06-21 15:01:25.4686] Slim::Schema::RemotePlaylist::getNextEntry (57) Considering http://deliciousagony.streamguys1.com/ (type: mp3)
[22-06-21 15:01:25.4692] Slim::Schema::RemotePlaylist::getNextEntry (66) Skipping http://deliciousagony.streamguys1.com/, we want the one after

**slartibartfast** · 2022-06-21, 07:08

Originally Posted by bpa

player.streaming.remote set to DEBUG will show the metadata parsing in remote streams

Code:

22-06-21 13:18:59.2236] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Helloween - Don't Run For Cover, from the 1985 album `Walls Of Jericho`';

Since there is silence - initial ideas (i) LMS stream processing has stopped or (ii) MP3 decoding has broken.

If player.streaming.remote logging is set to DEBUG then if stream is still "playing" - new metadata should keep appearing as long as stream is being played - this seems to be true for both direct and proxied.

If metadata keeps appearing but stream is silent then it would seem MP3 decode is at issue.
If metadata stops appearing - then it would appear that reading data from station has stopped.

Here is the complete log from stream start to finish

**bpa** · 2022-06-21, 07:14

Retsart the stream. There is something odd in the MP3 stream that causes the Radio to try to play the stream a few times in quick sucession and the track never plays - see red text. Maybe just one-off situation just after stream is started or maybe something else.

Code:

[22-06-21 15:08:26.1429] Slim::Schema::RemotePlaylist::getNextEntry (57) Considering http://deliciousagony.streamguys1.com/ (type: mp3)
[22-06-21 15:08:26.1432] Slim::Schema::RemotePlaylist::getNextEntry (66) Skipping http://deliciousagony.streamguys1.com/, we want the one after
[22-06-21 15:08:26.1446] Slim::Schema::RemoteTrack::updateOrCreate (388) http://www.deliciousagony.com/listen.pls
[22-06-21 15:08:26.1448] Slim::Schema::RemoteTrack::setAttributes (346) http://www.deliciousagony.com/listen.pls => {
  RATING => 0,
  REMOTE => 1,
  YEAR   => 0,
  urlmd5 => "4238b1ac8be7014453fcce069df82c40",
}
[22-06-21 15:08:26.4273] Slim::Schema::RemoteTrack::updateOrCreate (388) http://www.deliciousagony.com/listen.pls
[22-06-21 15:08:26.4282] Slim::Schema::RemoteTrack::setAttributes (346) http://www.deliciousagony.com/listen.pls => {
  CONTENT_TYPE => "pls",
  RATING => 0,
  REMOTE => 1,
  YEAR => 0,
  urlmd5 => "4238b1ac8be7014453fcce069df82c40",
}
[22-06-21 15:08:26.4306] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.4315] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  RATING      => 0,
  REMOTE      => 1,
  TITLE       => "Delicious Agony",
  TITLESEARCH => "DELICIOUS AGONY",
  TITLESORT   => "DELICIOUS AGONY",
  YEAR        => 0,
  urlmd5      => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 15:08:26.4323] Slim::Schema::RemotePlaylist::setTracks (25) http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.4331] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.4337] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  RATING => 0,
  REMOTE => 1,
  YEAR   => 0,
  urlmd5 => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 15:08:26.6990] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.6999] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  CONTENT_TYPE => "mp3",
  RATING => 0,
  REMOTE => 1,
  YEAR => 0,
  urlmd5 => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 15:08:26.7005] Slim::Schema::RemotePlaylist::getNextEntry (57) Considering http://deliciousagony.streamguys1.com/ (type: mp3)
[22-06-21 15:08:26.7009] Slim::Schema::RemotePlaylist::getNextEntry (74) Next playlist entry is http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.7017] Slim::Schema::RemoteTrack::updateOrCreate (388) http://www.deliciousagony.com/listen.pls
[22-06-21 15:08:26.7024] Slim::Schema::RemoteTrack::setAttributes (346) http://www.deliciousagony.com/listen.pls => {
  BITRATE   => 192_000,
  RATING    => 0,
  REMOTE    => 1,
  VBR_SCALE => undef,
  YEAR      => 0,
  urlmd5    => "4238b1ac8be7014453fcce069df82c40",
}
[22-06-21 15:08:26.7028] Slim::Schema::RemoteTrack::setAttributes (366) bitrate: 128000=>192000
[22-06-21 15:08:26.7037] Slim::Schema::RemotePlaylist::getNextEntry (57) Considering http://deliciousagony.streamguys1.com/ (type: mp3)
[22-06-21 15:08:26.7040] Slim::Schema::RemotePlaylist::getNextEntry (74) Next playlist entry is http://deliciousagony.streamguys1.com/
[22-06-21 15:08:26.7084] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 72 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 15:08:27.2432] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 15:08:27.2439] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  CONTENT_TYPE => "mp3",
  RATING => 0,
  REMOTE => 1,
  YEAR => 0,
  urlmd5 => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 15:08:27.5790] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Ambrosia - Somewhere I've Never Traveled, from the 1979 album `Wolfgang's Vault: Palladium, Dallas, TX`';
[22-06-21 15:09:05.7854] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 72 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 15:09:11.0086] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 72 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 15:09:21.0073] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 72 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 15:09:36.0085] Slim::Player::Squeezebox::stream_s (1015) Starting decoder with format: m flags: 0x0 autostart: 3 buffer threshold: 72 output threshold: 1 samplesize: ? samplerate: ? endian: ? channels: ?
[22-06-21 15:09:36.4133] Slim::Schema::RemoteTrack::updateOrCreate (388) http://deliciousagony.streamguys1.com/
[22-06-21 15:09:36.4142] Slim::Schema::RemoteTrack::setAttributes (346) http://deliciousagony.streamguys1.com/ => {
  CONTENT_TYPE => "mp3",
  RATING => 0,
  REMOTE => 1,
  YEAR => 0,
  urlmd5 => "de8197d9018e83b953629e5ec0165a11",
}
[22-06-21 15:09:36.8218] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='';
[22-06-21 15:09:37.1262] Slim::Schema::RemoteTrack::get (431) http://www.deliciousagony.com/listen.pls, title->Delicious Agony
[22-06-21 15:09:38.1483] Slim::Player::Protocols::HTTP::parseMetadata (286) Icy metadata received: StreamTitle='Elton John - Take Me To The Pilot, from the 1979 album `Live In Moscow`';

Thread: Radio station stops playing

Thread Tools

Search Thread

Display

Radio station stops playing

Posting Permissions