GNOME Bugzilla – Bug 708225
Rhythmbox either crashes or does nothing when trying to play internet radio
Last modified: 2013-09-19 21:48:32 UTC
Summary says it all. I can't play internet radio, either nothing happens or the Rhythmbox window freezes so that it must be killed. Same stream plays perfectly in VLC and other players. I suspect that this bug may be connected to gvfsd-http, because this process usually is very small and needs around 0% CPU time, but when trying to use Rhythmbox to play radio, its memory usage grows and it uses 1-2% CPU time (on a 1,6 GHz Atom processor) Here is a debug log, starting at that point where I have selected a radio station from the list and pressed the Play button: (13:09:11) [0x9e0d720] [rb_shell_player_cmd_play] rb-shell-player.c:2338: play! (13:09:11) [0x9e0d720] [rb_shell_player_playpause] rb-shell-player.c:2367: doing playpause (13:09:11) [0x9e0d720] [rb_shell_player_playpause] rb-shell-player.c:2402: no playing source, using selected source (13:09:11) [0x9e0d720] [rb_shell_player_set_playing_source_internal] rb-shell-player.c:3124: setting playing source to 0x9f72200 (13:09:11) [0x9e0d720] [player_has_prev_changed_cb] rb-mpris-plugin.c:1310: emitting CanGoPrevious change (13:09:11) [0x9e0d720] [rb_shell_player_sync_with_source] rb-shell-player.c:2948: playing source: 0x9f72200, active entry: (nil) (13:09:11) [0x9e0d720] [rb_shell_set_window_title] rb-shell.c:2638: clearing title (13:09:11) [0x9e0d720] [rb_shell_player_sync_buttons] rb-shell-player.c:3039: syncing with source 0x9f72200 (13:09:11) [0x9e0d720] [rb_shell_playing_source_changed_cb] rb-shell.c:2525: playing source changed (13:09:11) [0x9e0d720] [playing_source_changed_cb] rb-mpris-plugin.c:1286: emitting CanPause change (13:09:11) [0x9e0d720] [playing_source_changed_cb] rb-mpris-plugin.c:1289: emitting ActivePlaylist change (13:09:11) [0x9e0d720] [playing_source_changed_cb] rb-iradio-source.c:1141: connecting info-available signal handler (13:09:11) [0x9e0d720] [rb_shell_player_playpause] rb-shell-player.c:2427: choosing first selected entry (13:09:11) [0x9e0d720] [player_has_next_changed_cb] rb-mpris-plugin.c:1298: emitting CanGoNext change (13:09:11) [0x9e0d720] [rb_shell_player_set_playing_entry] rb-shell-player.c:1797: Success! (13:09:11) [0x9e0d720] [rb_shell_player_sync_with_source] rb-shell-player.c:2948: playing source: 0x9f72200, active entry: 0xa833e5a8 (13:09:11) [0x9e0d720] [rb_shell_set_window_title] rb-shell.c:2661: setting title to "Psychedelik.com Ambient" (13:09:11) [0x9e0d720] [rb_shell_player_sync_buttons] rb-shell-player.c:3039: syncing with source 0x9f72200 (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2195: paned position 160 (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2202: right_paned position 570 (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2209: sidebar paned position 300 (13:09:12) [0xaac8180] [playlist_entry_cb] rb-shell-player.c:1560: adding stream url http://88.191.102.69:8002 (0xa95cd90) (13:09:12) [0xaac8180] [playlist_entry_cb] rb-shell-player.c:1560: adding stream url http://88.191.145.93:8002 (0xa95cd90) (13:09:12) [0xaac8180] [playlist_entry_cb] rb-shell-player.c:1560: adding stream url http://88.191.143.89:8002 (0xa95cd90) (13:09:12) [0xaac8180] [playlist_entry_cb] rb-shell-player.c:1560: adding stream url http://88.191.147.144:8002 (0xa95cd90) (13:09:12) [0xaac8180] [playlist_entry_cb] rb-shell-player.c:1560: adding stream url http://dab.no:8102 (0xa95cd90) (13:09:12) [0xaac8180] [open_location_thread] rb-shell-player.c:1601: playing first stream url http://88.191.102.69:8002 (13:09:12) [0xaac8180] [rb_shell_player_open_playlist_url] rb-shell-player.c:780: playing stream url http://88.191.102.69:8002 (13:09:12) [0xaac8180] [rb_player_gst_try_audio_sink] rb-player-gst-helper.c:91: audio sink autoaudiosink changed to READY state successfully (13:09:12) [0xaac8180] [create_stream] rb-player-gst-xfade.c:2074: creating new stream for http://88.191.102.69:8002 (stream data 0xa833e5a8) (13:09:12) [0xaac8180] [dump_stream_list] rb-player-gst-xfade.c:496: current stream list: (13:09:12) [0xaac8180] [dump_stream_list] rb-player-gst-xfade.c:519: [waiting] http://88.191.102.69:8002 (13:09:12) [0xaac8180] [stream_source_setup_cb] rb-player-gst-xfade.c:1943: got source notification for stream http://88.191.102.69:8002 (13:09:12) [0xaac8180] [start_sink_locked] rb-player-gst-xfade.c:2730: starting sink (13:09:12) [0xaac8180] [start_sink_locked] rb-player-gst-xfade.c:2826: adder is now PAUSED (13:09:12) [0xaac8180] [start_sink_locked] rb-player-gst-xfade.c:2828: silencebin is now PAUSED (13:09:12) [0x9e0d720] [window_focus_cb] rb-mmkeys-plugin.c:169: window got focus, re-grabbing media keys (13:09:12) [0x9e0d720] [window_focus_cb] rb-mmkeys-plugin.c:169: window got focus, re-grabbing media keys (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2195: paned position 160 (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2202: right_paned position 570 (13:09:12) [0x9e0d720] [sync_window_settings] rb-shell.c:2209: sidebar paned position 300 (13:09:13) [0xa8309150] [stream_pad_added_cb] rb-player-gst-xfade.c:1976: got decoded audio pad for stream http://88.191.102.69:8002 (13:09:13) [0xaac8180] [start_sink_locked] rb-player-gst-xfade.c:2823: outputbin is now PAUSED (13:09:13) [0xaac8180] [rb_player_gst_find_element_with_property] rb-player-gst-helper.c:132: iterating bin looking for property volume (13:09:13) [0xaac8180] [find_property_element] rb-player-gst-helper.c:107: found property "volume" on element autoaudiosink0-actual-sink-pulse (13:09:13) [0xaac8180] [start_sink_locked] rb-player-gst-xfade.c:2891: sink playing (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 0 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 1 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 10 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 11 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 12 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 13 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 14 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 15 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 16 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 17 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 18 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 19 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 20 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 21 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 22 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 23 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 24 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 25 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 26 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 27 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 26 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 27 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 28 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 29 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 30 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 31 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 32 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 33 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 34 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 35 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1873: still buffering, 36 (13:09:13) [0xaac8180] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1694: got tag message for unknown stream (13:09:13) [0xaac8180] [rb_player_gst_xfade_play] rb-player-gst-xfade.c:3461: playing stream http://88.191.102.69:8002, play type 0, crossfade 3000000000 (13:09:13) [0xaac8180] [rb_player_gst_xfade_play] rb-player-gst-xfade.c:3469: stream http://88.191.102.69:8002 is prerolling; will start playback once prerolling is complete -> PREROLL_PLAY (13:09:13) [0xb09122f0] [stream_src_blocked_cb] rb-player-gst-xfade.c:2471: stream http://88.191.102.69:8002 requires buffering (13:09:13) [0xb09122f0] [post_stream_playing_message] rb-player-gst-xfade.c:840: posting rb-stream-playing message for stream http://88.191.102.69:8002 (13:09:14) [0x9e0d720] [get_times_and_stream] rb-player-gst-xfade.c:2590: found buffering stream http://88.191.102.69:8002 as current (13:09:14) [0x9e0d720] [tick_cb] rb-shell-player.c:3605: got tick for unexpected entry 0xa833e5a8 (expected (nil)) (13:09:14) [0x9e0d720] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1738: got stream playing message for http://88.191.102.69:8002 (13:09:14) [0x9e0d720] [playing_stream_cb] rb-shell-player.c:3539: new playing stream: http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [rb_ext_db_request] rb-ext-db.c:680: starting metadata request (13:09:14) [0x9e0d720] [EmbeddedSearch.search] /usr/lib/rhythmbox/plugins/artsearch/embedded.py:120: not searching in non-local file http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [LocalSearch.search] /usr/lib/rhythmbox/plugins/artsearch/local.py:295: searching for local art for http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [rb_header_sync] rb-header.c:734: syncing with entry = http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [rb_audioscrobbler_song_changed_cb] rb-audioscrobbler.c:1069: new entry: http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [get_times_and_stream] rb-player-gst-xfade.c:2590: found buffering stream http://88.191.102.69:8002 as current (13:09:14) [0x9e0d720] [rb_audioscrobbler_is_queueable] rb-audioscrobbler.c:564: entry http://psychedelik.com/flux/tunein-ambient.pls is not queueable: category not NORMAL (13:09:14) [0x9e0d720] [rb_audioscrobbler_song_changed_cb] rb-audioscrobbler.c:1069: new entry: http://psychedelik.com/flux/tunein-ambient.pls (13:09:14) [0x9e0d720] [get_times_and_stream] rb-player-gst-xfade.c:2590: found buffering stream http://88.191.102.69:8002 as current (13:09:14) [0x9e0d720] [rb_audioscrobbler_is_queueable] rb-audioscrobbler.c:564: entry http://psychedelik.com/flux/tunein-ambient.pls is not queueable: category not NORMAL (13:09:14) [0x9e0d720] [rb_ext_db_request] rb-ext-db.c:680: starting metadata request (13:09:14) [0x9e0d720] [rb_ext_db_request] rb-ext-db.c:716: found existing equivalent request (13:09:14) [0x9e0d720] [do_notify] rb-notification-plugin.c:154: notification server does not support actions (13:09:14) [0x9e0d720] [do_notify] rb-notification-plugin.c:160: notification server does not support persistence (13:09:15) [0x9e0d720] [playing_entry_changed_cb] rb-mpris-plugin.c:1210: emitting Metadata and CanSeek changed (13:09:15) [0x9e0d720] [add_string_property] rb-mpris-plugin.c:374: adding xesam:url = http://psychedelik.com/flux/tunein-ambient.pls (13:09:15) [0x9e0d720] [add_string_property_2] rb-mpris-plugin.c:399: adding xesam:title = Psychedelik.com Ambient (13:09:15) [0x9e0d720] [add_string_property] rb-mpris-plugin.c:374: adding xesam:genre = Electronic (13:09:15) [0x9e0d720] [add_ulong_property] rb-mpris-plugin.c:420: adding xesam:audioBitrate = 192 (13:09:15) [0x9e0d720] [add_ulong_property_as_int64] rb-mpris-plugin.c:437: adding mpris:length = 0 (13:09:15) [0x9e0d720] [add_ulong_property] rb-mpris-plugin.c:420: adding xesam:trackNumber = 0 (13:09:15) [0x9e0d720] [add_ulong_property] rb-mpris-plugin.c:420: adding xesam:useCount = 4 (13:09:15) [0x9e0d720] [add_double_property] rb-mpris-plugin.c:453: adding xesam:userRating = 0,000000 (13:09:15) [0x9e0d720] [playing_entry_changed_cb] rb-streaming-source.c:489: playing new stream; resetting buffering (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_shell_player_sync_with_source] rb-shell-player.c:2948: playing source: 0x9f72200, active entry: 0xa833e5a8 (13:09:15) [0x9e0d720] [get_times_and_stream] rb-player-gst-xfade.c:2590: found buffering stream http://88.191.102.69:8002 as current (13:09:15) [0x9e0d720] [rb_shell_player_sync_buttons] rb-shell-player.c:3039: syncing with source 0x9f72200 (13:09:15) [0x9e0d720] [playing_changed_cb] rb-mpris-plugin.c:1190: emitting PlaybackStatus change (13:09:15) [0x9e0d720] [get_times_and_stream] rb-player-gst-xfade.c:2590: found buffering stream http://88.191.102.69:8002 as current (13:09:15) [0x9e0d720] [tick_cb] rb-shell-player.c:3623: tick: [http://psychedelik.com/flux/tunein-ambient.pls, 0:0(0)] (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [sync_window_settings] rb-shell.c:2195: paned position 160 (13:09:15) [0x9e0d720] [sync_window_settings] rb-shell.c:2202: right_paned position 570 (13:09:15) [0x9e0d720] [sync_window_settings] rb-shell.c:2209: sidebar paned position 300 (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1694: got tag message for unknown stream (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_statusbar_page_status_changed_cb] rb-statusbar.c:544: source status changed (13:09:15) [0x9e0d720] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1854: stream http://88.191.102.69:8002 is buffered, now playing (13:09:15) [0x9e0d720] [actually_start_stream] rb-player-gst-xfade.c:2287: going to start playback for stream http://88.191.102.69:8002 (play type 0, crossfade 3000000000) -> FADING_IN | PLAYING (13:09:15) [0x9e0d720] [link_and_unblock_stream] rb-player-gst-xfade.c:1066: linking stream http://88.191.102.69:8002 (13:09:15) [0x9e0d720] [stream_src_event_cb] rb-player-gst-xfade.c:2046: got reconfigure event for stream http://88.191.102.69:8002 (13:09:15) [0x9e0d720] [link_and_unblock_stream] rb-player-gst-xfade.c:1097: now have 1 linked streams (13:09:15) [0xb09122f0] [stream_src_event_cb] rb-player-gst-xfade.c:2046: got caps event for stream http://88.191.102.69:8002 (13:09:15) [0xb09122f0] [stream_src_event_cb] rb-player-gst-xfade.c:2046: got stream-start event for stream http://88.191.102.69:8002 (13:09:15) [0xb09122f0] [stream_src_event_cb] rb-player-gst-xfade.c:2036: got new segment for stream http://88.191.102.69:8002 Killed
PS: running with Ubuntu 13.04 and latest updates
Thanks for the bug report. This particular bug has already been reported into our bug tracking system, but please feel free to report any further bugs you find. *** This bug has been marked as a duplicate of bug 695652 ***