Re: [Rhythmbox-devel] Rhythmbox won't play files

[John Iacona <plate0salad gmail com>]

Renato,
It makes things a lot easier if you write the output to a file when
displaying the full debug info. Try running: rhythmbox -d 2>
rb-debug.log. All output will then end up in the file rb-debug.log.

Regards,
John Iacona

On Tue, Aug 11, 2009 at 7:51 AM, Renato <rennabh gmail com> wrote:
>
> > Running 'rhythmbox -d' may provide you (us) with more useful
> > output.
> >
>
> wow, that's a lot of ouput! After the database checking finished, i
> pushed play and as soon as i could i killed the process from the
> terminal. here's the output
>
> $ rhythmbox -d
> [..database checking..]
> (13:47:52) [0x9e47028] [rb_shell_player_cmd_play]
> rb-shell-player.c:2254: play! (13:47:52) [0x9e47028]
> [rb_shell_player_playpause] rb-shell-player.c:2283: doing playpause
> (13:47:52) [0x9e47028] [rb_shell_player_playpause]
> rb-shell-player.c:2314: no playing source, using selected source
> (13:47:52) [0x9e47028] [rb_shell_player_set_playing_source_internal]
> rb-shell-player.c:3079: setting playing source to 0x9fb0178 (13:47:52)
> [0x9e47028] [rb_shell_player_sync_with_source] rb-shell-player.c:2895:
> playing source: 0x9fb0178, active entry: (nil) (13:47:52) [0x9e47028]
> [rb_shell_set_window_title] rb-shell.c:1983: clearing title (13:47:52)
> [0x9e47028] [show_controls] rb-visualizer-plugin.c:866: showing
> controls (13:47:52) [0x9e47028]
> [rb_shell_player_get_playing_song_duration] rb-shell-player.c:3338: Did
> not get playing entry : return -1 as length (13:47:52) [0x9e47028]
> [rb_header_sync] rb-header.c:461: syncing with entry = <null>
> (13:47:52) [0x9e47028] [rb_header_sync] rb-header.c:537: not playing
> (13:47:52) [0x9e47028] [rb_shell_player_sync_buttons]
> rb-shell-player.c:2998: syncing with source 0x9fb0178 (13:47:52)
> [0x9e47028] [rb_shell_playing_source_changed_cb] rb-shell.c:1861:
> playing source changed (13:47:52) [0x9e47028]
> [rb_shell_player_playpause] rb-shell-player.c:2352: getting entry from
> play order (13:47:52) [0x9e47028] [rb_shuffle_play_order_get_next]
> rb-play-order-shuffle.c:206: choosing current entry in shuffle
> (13:47:52) [0x9e47028] [rb_player_gst_try_audio_sink]
> rb-player-gst-helper.c:61: setting profile property on gconfaudiosink
> (13:47:52) [0x9e47028] [rb_player_gst_try_audio_sink]
> rb-player-gst-helper.c:81: audio sink gconfaudiosink changed to READY
> state successfully (13:47:52) [0x9e47028] [create_stream]
> rb-player-gst-xfade.c:2007: creating new stream for
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (stream data 0xb49188c8) (13:47:52) [0x9e47028] [dump_stream_list]
> rb-player-gst-xfade.c:513: current stream list: (13:47:52) [0x9e47028]
> [dump_stream_list] rb-player-gst-xfade.c:536: [waiting]
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [start_sink_locked] rb-player-gst-xfade.c:2681:
> starting sink (13:47:52) [0x9f1bf98] [stream_new_decoded_pad_cb]
> rb-player-gst-xfade.c:1890: got decoded audio pad for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [start_sink_locked] rb-player-gst-xfade.c:2777:
> adder is now PAUSED (13:47:52) [0x9e47028] [start_sink_locked]
> rb-player-gst-xfade.c:2779: silencebin is now PAUSED (13:47:52)
> [0x9f1bf98] [stream_src_blocked_cb] rb-player-gst-xfade.c:2438: stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> is prerolled, not starting yet -> WAITING (13:47:52) [0xacfedc0]
> [stream_src_blocked_cb] rb-player-gst-xfade.c:2424: stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> already blocked (13:47:52) [0x9e47028] [start_sink_locked]
> rb-player-gst-xfade.c:2774: outputbin is now PAUSED (13:47:52)
> [0x9e47028] [rb_player_gst_find_element_with_property]
> rb-player-gst-helper.c:121: iterating bin looking for property volume
> (13:47:52) [0x9e47028] [find_property_element]
> rb-player-gst-helper.c:99: didn't find property "volume" on element
> bin3 (13:47:52) [0x9e47028] [find_property_element]
> rb-player-gst-helper.c:99: didn't find property "volume" on element
> pulsesink0 (13:47:52) [0x9e47028] [start_sink_locked]
> rb-player-gst-xfade.c:2800: sink doesn't provide volume control, using
> volume element (13:47:52) [0x9e47028] [start_sink_locked]
> rb-player-gst-xfade.c:2842: sink playing (13:47:52) [0x9e47028]
> [rb_player_gst_xfade_play] rb-player-gst-xfade.c:3412: playing stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3,
> play type 0, crossfade 1000000000 (13:47:52) [0x9e47028]
> [actually_start_stream] rb-player-gst-xfade.c:2247: going to start
> playback for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (play type 0, crossfade 1000000000) -> FADING_IN | PLAYING (13:47:52)
> [0x9e47028] [link_and_unblock_stream] rb-player-gst-xfade.c:1140:
> linking stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [link_and_unblock_stream]
> rb-player-gst-xfade.c:1171: now have 1 linked streams (13:47:52)
> [0x9e47028] [rb_shell_player_set_playing_entry] rb-shell-player.c:1682:
> Success! (13:47:52) [0x9f1bf98] [link_unblocked_cb]
> rb-player-gst-xfade.c:1097: stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> is unblocked -> FADING_IN | PLAYING (13:47:52) [0xacfedc0]
> [link_unblocked_cb] rb-player-gst-xfade.c:1092: stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> already unblocked (13:47:52) [0xacfedc0] [stream_src_event_cb]
> rb-player-gst-xfade.c:1971: got new segment for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [rb_shell_player_sync_with_source]
> rb-shell-player.c:2895: playing source: 0x9fb0178, active entry:
> 0xb49188c8 (13:47:52) [0x9f1bf98] [adjust_stream_base_time]
> rb-player-gst-xfade.c:920: unable to adjust base time as position query
> failed (13:47:52) [0xacfedc0] [adjust_stream_base_time]
> rb-player-gst-xfade.c:920: unable to adjust base time as position query
> failed (13:47:52) [0xacfedc0] [stream_src_event_cb]
> rb-player-gst-xfade.c:1981: got tag event for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9f1bf98] [link_unblocked_cb] rb-player-gst-xfade.c:1111:
> stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> state change returned: SUCCESS (13:47:52) [0x9f1bf98]
> [post_stream_playing_message] rb-player-gst-xfade.c:863: posting
> rb-stream-playing message for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [rb_shell_set_window_title] rb-shell.c:2006:
> setting title to "Jovanotti - La Pace" (13:47:52) [0x9e47028]
> [show_controls] rb-visualizer-plugin.c:866: showing controls (13:47:52)
> [0xacfedc0] [adjust_base_time_probe_cb] rb-player-gst-xfade.c:876:
> attempting to adjust base time for stream
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0xacfedc0] [adjust_stream_base_time]
> rb-player-gst-xfade.c:920: unable to adjust base time as position query
> failed (13:47:52) [0x9e47028] [rb_header_sync] rb-header.c:461: syncing
> with entry =
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [rb_shell_player_sync_buttons]
> rb-shell-player.c:2998: syncing with source 0x9fb0178 (13:47:52)
> [0x9e47028] [rb_player_gst_xfade_bus_cb] rb-player-gst-xfade.c:1734:
> got stream playing message for
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [playing_stream_cb] rb-shell-player.c:3435: new
> playing stream:
> file:///home/renato/Audio/Musica/rockeggiantes/Jovanotti%20-%20Discografia/%5B1997%5D.Lorenzo%201997%20L'albero/19%20-%20La%20pace.mp3
> (13:47:52) [0x9e47028] [should_notify] rb-status-icon-plugin.c:453:
> shell is visible, not notifying
> ^C
>
> Renato
> _______________________________________________
> rhythmbox-devel mailing list
> rhythmbox-devel gnome org
> http://mail.gnome.org/mailman/listinfo/rhythmbox-devel