rhythmbox freezes when opening certain radiostations first

[David Hof]

Binary package hint: rhythmbox

When I open rhythmbox and play specific radio streams, rhythmbox freezes. It never comes back. This only happens if it is the first time I open a stream with it. If I open another stream first and then open the 'bad' stream, no problem.

The message rhythmbox gives is:
 didn't expect to get preroll completion callback in this state (1)

The offending radio stream is http://server-06.stream-server.nl:8080
The 'always good' stream is http://82.94.255.191:8000/high.m3u

Ubuntu 8.10 on amd64.

Here is the more comprehensive output from rhythmbox:
------------------------------------------------------------------------------------------------------------------------------------------------
(20:22:34) [0x9aad50] [rb_shell_player_open_playlist_url] rb-shell-player.c:755: playing stream url http://server-06.stream-server.nl:8080
(20:22:34) [0x9aad50] [create_stream] rb-player-gst-xfade.c:2000: creating new stream for http://server-06.stream-server.nl:8080 (stream data 0x7f5e940074f0)
(20:22:34) [0x9aad50] [dump_stream_list] rb-player-gst-xfade.c:505: current stream list:
(20:22:34) [0x9aad50] [dump_stream_list] rb-player-gst-xfade.c:528: [waiting] http://server-06.stream-server.nl:8080
(20:22:34) [0x186ea40] [stream_queue_underrun_cb] rb-player-gst-xfade.c:1837: http://server-06.stream-server.nl:8080: queue underrun
(20:22:34) [0x186ea40] [post_stream_playing_message] rb-player-gst-xfade.c:828: posting rb-stream-playing message for stream http://server-06.stream-server.nl:8080
(20:22:34) [0x7f8500] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1677: got stream playing message for http://server-06.stream-server.nl:8080
(20:22:34) [0x7f8500] [new_playing_stream_idle_cb] rb-shell-player.c:3478: new playing stream: http://server-06.stream-server.nl:8080
(20:22:34) [0x7f8500] [rb_shell_hidden_notify_markup] rb-shell.c:3121: shell is visible, not notifying
(20:22:34) [0x9aad50] [start_sink] rb-player-gst-xfade.c:2645: starting sink
(20:22:34) [0x7f8500] [LocalCoverArtSearch.search] /usr/lib/rhythmbox/plugins/artdisplay/LocalCoverArtSearch.py:138: not searching for local art for http://server-06.stream-server.nl:8080/
(20:22:34) [0x7f8500] [rb_audioscrobbler_song_changed_cb] rb-audioscrobbler.c:1293: new entry: http://server-06.stream-server.nl:8080
(20:22:34) [0x1ac3410] [stream_queue_probe_cb] rb-player-gst-xfade.c:1804: http://server-06.stream-server.nl:8080: buffer level: 0; threshold 65536 - 0%
(20:22:34) [0x9aad50] [start_sink] rb-player-gst-xfade.c:2746: passing message to bus callback
(20:22:34) [0x9aad50] [start_sink] rb-player-gst-xfade.c:2746: passing message to bus callback
(20:22:34) [0x9aad50] [process_tag] rb-player-gst-xfade.c:1454: got tag organization for stream http://server-06.stream-server.nl:8080
(20:22:34) [0x9aad50] [process_tag] rb-player-gst-xfade.c:1454: got tag genre for stream http://server-06.stream-server.nl:8080
(20:22:34) [0x9aad50] [process_tag] rb-player-gst-xfade.c:1493: emitting info field 4 for uri http://server-06.stream-server.nl:8080
(20:22:34) [0x1ac3410] [stream_queue_probe_cb] rb-player-gst-xfade.c:1804: http://server-06.stream-server.nl:8080: buffer level: 1305; threshold 65536 - 1%
------------------------------------------------------------------------
removed some lines here...
------------------------------------------------------------------------
(20:22:34) [0x1ac3410] [stream_queue_probe_cb] rb-player-gst-xfade.c:1804: http://server-06.stream-server.nl:8080: buffer level: 65017; threshold 65536 - 98%
(20:22:34) [0x186ea40] [stream_queue_threshold_cb] rb-player-gst-xfade.c:1816: http://server-06.stream-server.nl:8080: queue running
(20:22:35) [0x186ea40] [stream_new_decoded_pad_cb] rb-player-gst-xfade.c:1890: got decoded audio pad for stream http://server-06.stream-server.nl:8080
(20:22:35) [0x186ea40] [stream_src_blocked_cb] rb-player-gst-xfade.c:2423: stream http://server-06.stream-server.nl:8080 is prerolled, not starting yet -> WAITING
(20:22:35) [0x1871b50] [stream_src_blocked_cb] rb-player-gst-xfade.c:2434: didn't expect to get preroll completion callback in this state (1)

[benste (benste)]

Thank you for reporting this bug,
but I can't reproduce it on a intel machine with your dutch radio station.
Maybe someone else will be able to do.

[Sebastien Bacher (seb128)]

Thank you for taking the time to report this bug and helping to make Ubuntu better. Please try to obtain a backtrace following the instructions at http://wiki.ubuntu.com/DebuggingProgramCrash and upload the backtrace (as an attachment) to the bug report. This will greatly help us in tracking down your problem.

[Pedro Villavicencio (pedro)]

We are closing this bug report because it lacks the information we need to investigate the problem, as described in the previous comments. Please reopen it if you can give us the missing information, and don't hesitate to submit bug reports in the future. To reopen the bug report you can click on the current status, under the Status column, and change the Status back to New. Thanks again!.

[David Hof (david-hofstee)]

Hi,

I'm sorry for my late response, I must have missed the email. The backtrace is attached... Thanks,

David

[David Hof (david-hofstee)]

as requested...

[Sebastien Bacher (seb128)]

do you get the issue if you don't use the crossfading option?

[David Hof (david-hofstee)]

No! :-), and it is much snappier in the process.

[Jonathan Kyler (fblack947)]

I get the same with 32-bit version of 8.10.

Rhythmbox debug messages attached.

As described, the crash occurs when trying to play the stream for the first time after a log in. After killing rhythmbox and restarting, the stream plays normally.

[Jonathan Kyler (fblack947)]

Attached is rhythmbox's debugging info from the next, successful attempt to stream the station.

Does look like it's related to crossfading.

[Kurt Wall (kwall)]

I tried to repro this bug in 32-bit 9.04 (rhythmbox 0.12.0-0ubuntu4). Unfortunately, RB wouldn't freeze. /However/, I get different behavior that still seems to implicate cross-fading.

With cross-fading enabled:

0) Login.
1) Start RB.
2) Attempt to connect to the reporter's "bad" radio stream (http://server-06.stream-server.nl:8080/).
3) The connect attempt starts, followed by a dialog reading: "Couldn't start playback. Failed to open output device."

With cross-fading disabled:

0) Login.
1) Start RB.
2) Attempt to connect to the reporter's "bad" radio stream (http://server-06.stream-server.nl:8080/).
3) The connect attempt succeeds and music starts playing

However, I was unable to reproduce this behavior within GDB. In GDB, wIth debug symbols installed and cross-fading enabled, the music starts. The same obtains with cross-fading disabled whilst running under GDB. The fact that this reliably reproduces (for me, on 9.04) without the debugging symbols loaded but will not reproduce in a debugger suggests a race condition.

[Jeff Fortin Tam (kiddo)]

I have been suffering from this a lot in ubuntu 9.04 with my two radio stations*. I did not find a bug upstream, shouldn't one be created?

*: http://www.somafm.com/groovesalad.pls and http://stream.mth-house.de:8500/listen.pls

[Sebastien Bacher (seb128)]

Would be nice if somebody having the issue would open an upstream bug indeed

[Jeff Fortin Tam (kiddo)]

Could also be related to http://bugzilla.gnome.org/show_bug.cgi?id=468905
(initially filed downstream as https://bugzilla.redhat.com/show_bug.cgi?id=186532 )

But I'm not sure.

[Jeff Fortin Tam (kiddo)]

Upstream marked it as a duplicate.

[Sebastien Bacher (seb128)]

the bug is fixed in the karmic version