GNOME Bugzilla – Bug 612929
[Gapless] Last.fm plays two songs, then gets html file rather than music from Last.fm
Last modified: 2012-02-22 20:05:47 UTC
Hello there, since I updated to 1.5.5 (Debian Sid, AMD64) I have noticed this behavior in the last.fm plugin. I start banshee, double click on a last.fm radio station, and the music starts. At the end of the first track, the second is buffered very slowly (about 10s of silence before playback starts), and at the end of the second song the playback stops. At this point I double click on a song in the playlist and the music resumes, the next track is slowly buffered and then it stops, rinse, repeat. This is the output I collected running banshee from terminal (I add comments to describe what I'm doing): 1) Start banshee jack@nostromo:~$ banshee [Info 11:18:10.790] Running Banshee 1.5.5: [Debian GNU/Linux unstable (sid) (linux-gnu, x86_64) @ 2010-03-11 21:33:59 UTC] [Info 11:18:12.486] All services are started 1.430551s [Info 11:18:13.910] nereid Client Started 2) Double click on last.fm station [Warn 11:18:28.760] Caught an exception - The remote server returned an error: (404) Not Found. (in `System') at System.Net.HttpWebRequest.CheckFinalStatus (System.Net.WebAsyncResult result) [0x00000] at System.Net.HttpWebRequest.SetResponseData (System.Net.WebConnectionData data) [0x00000] 3) End of second song, station stalls [Error 11:26:57.655] GStreamer resource error: OpenRead [Error 11:26:58.041] GStreamer resource error: OpenRead [Error 11:26:58.428] GStreamer resource error: OpenRead [Error 11:26:58.809] GStreamer resource error: OpenRead [Error 11:26:59.193] GStreamer resource error: OpenRead 4) Double click on next song in playlist [Warn 11:27:19.863] Caught an exception - The remote server returned an error: (404) Not Found. (in `System') at System.Net.HttpWebRequest.CheckFinalStatus (System.Net.WebAsyncResult result) [0x00000] at System.Net.HttpWebRequest.SetResponseData (System.Net.WebConnectionData data) [0x00000] Any more debugging I can do? Thanks for your help!
I think may I have this problem too. I have to play a track with SHIFT+SPACE to stop it moving to the next track at the end of the song. If I let it run through the playlist automatically, it will inevitably stop and put an X next to the tracks. Often, last.fm shows two consecutive entries for a single song I've listened to in Banshee. Sometimes, it will even scrobble the wrong track. I've been using the daily PPA in Lucid Lynx and this has only been happening for a week or so.
*** Bug 613337 has been marked as a duplicate of this bug. ***
I can't test this because I'm not a subscriber, but I'm confirming based on Comment 1 and the duplicate report.
(In reply to comment #3) > I can't test this because I'm not a subscriber, but I'm confirming based on > Comment 1 and the duplicate report. If you want I can provide you (privately :D) with my login information. Just to confirm it's not an API breaking, the official last.fm client works just fine.
(In reply to comment #4) > (In reply to comment #3) > > I can't test this because I'm not a subscriber, but I'm confirming based on > > Comment 1 and the duplicate report. > > If you want I can provide you (privately :D) with my login information. > Just to confirm it's not an API breaking, the official last.fm client works > just fine. As tempting as it is to take you up on that offer - man, I miss listening to Last.fm in Banshee - Bertrand tends to fix a lot of the Last.fm plugin issues, and I'm pretty sure he's a subscriber. Thanks anyway, though. :)
I'm also seeing this behavior, and can send additional debug information if needed.
*** Bug 614013 has been marked as a duplicate of this bug. ***
This is just a big ol' "me too" on this issue. I'm running 1.5.6.
I'm running 1.6 in the newly released lucid lynx. Same behavior. I too can provide any additional info if needed.
I am running version 1.7 and am still experiencing this problem (I have been since 1.5). This is a huge issue to me, and I would really like to see it resolved. To that end - is there any additional information I can provide, anything I can do to help, etc...?
*** Bug 623165 has been marked as a duplicate of this bug. ***
For what it's worth, the last banshee version that was not affected by these problems in the last.fm playback was 1.5.5+git20100307.r1.b1f45c7, right before some pretty big changes in the plugin were made. Perhaps this might help to track down the problem.
Banshee 1.6.1 on Fedora 13 has this problem too: $ banshee-1 [Info 22:52:29.219] Running Banshee 1.6.1: [Fedora13-1.6.1-3.fc13 (linux-gnu, x86_64) @ 2010-06-26 21:33:53 UTC] [Info 22:52:34.230] All services are started 4,159314 [Info 22:52:36.020] nereid Client Started [Warn 22:52:50.569] Caught an exception - System.Net.WebException: The remote server returned an error: (404) Not Found. (in `System') at System.Net.HttpWebRequest.CheckFinalStatus (System.Net.WebAsyncResult result) [0x00000] in <filename unknown>:0 at System.Net.HttpWebRequest.SetResponseData (System.Net.WebConnectionData data) [0x00000] in <filename unknown>:0 [Info 22:52:51.458] Uncached artwork size 232 requested [Info 22:56:27.831] Uncached artwork size 232 requested [Info 22:56:27.975] Uncached artwork size 232 requested [Error 23:00:10.017] GStreamer resource error: OpenRead [Error 23:00:10.044] GStreamer stream error: CodecNotFound [Error 23:00:10.103] GStreamer stream error: Failed ** Message: PackageKit: xid = 92274733 ** Message: PackageKit: Codec nice name: Dekoder text/html ** Message: PackageKit: structure: gstreamer0.10(decoder-text/html)()(64bit) [Error 23:00:10.514] GStreamer resource error: OpenRead ** Message: PackageKit: Did not install codec: did not agree to search [Error 23:00:16.491] GStreamer resource error: OpenRead [Error 23:00:16.883] GStreamer resource error: OpenRead [Error 23:00:17.300] GStreamer resource error: OpenRead [Error 23:00:17.727] GStreamer resource error: OpenRead
This issue is present in version 1.7.4 too...
This issue is also present in version 1.7.5, installed from the following PPA: deb http://ppa.launchpad.net/banshee-team/banshee-unstable/ubuntu lucid main
This bug is still present in 1.7.6. Banshee's Last.fm integration is one of the key reasons for using the product, but with this bug, it is basically useless. This has been going on since version 1.5.5, and I can't believe that nothing seems to have been done about it. Please, please, please, can this be made a priority for version 1.8?
Confirmed as present in 1.8.0 here: http://www.omgubuntu.co.uk/2010/09/banshee-1-8-0-released/#comment-83230322
Could someone experiencing this please attach a full --debug log showing this issue (1.8.0 would be good, confirming on git master/Ubuntu daily ppa would be better). It looks like last.fm returns a 404 so maybe we aren't using their API correctly but so far nobody seems to have attached a full debug log to examine this issue more fully. So please someone run banshee-1 --debug --redirect-log reproduce the issue, quit banshee and upload the resulting ~/.config/banshee-1/log
Created attachment 174116 [details] Log file, as requested by David Nielsen Here's the log you requested David. This is from the latest build in the daily ppa (ppa:banshee-team/banshee-daily). Symptoms are the same as reported above: it played two songs from the Last.fm stream and then stopped. At that point it displayed a "Search for Suitable Plugins" dialog box.
The problem is clearly that we always get an html answer the 3rd time for some reason. [1 Debug 02:45:42.588] (libbanshee:player) Saving missing element details ('gstreamer|0.10|Banshee|text/html decoder|decoder-text/html') Since gstreamer can't, for obvious reasons, play such files it will trigger the search for suitable plugins dialog. looking at the log it seems to go something like: playback nearly finished, request next song for gapless playback, for some reason get html back, playback finished, attempt to open html file and boom. [14 Debug 02:45:42.313] (libbanshee:player) [Gapless] Requesting next track [1 Debug 02:45:42.570] (libbanshee:player) bp_stop: setting state to GST_STATE_NULL [1 Debug 02:45:42.571] Player state change: Playing -> Idle [1 Error 02:45:42.585] GStreamer resource error: OpenRead Does this happen with gapless playback disabled as well (a similar log would be good)?
Good spot. With gapless playback disabled I'm not getting the same issue. I've been able to play several consecutive songs, and been able to pause/resume. So this is certainly a workaround for now. Do you still want a log of a gapless-disabled run?
It might be a good idea to have that. I think we have other similar bugs relating to gapless playback similar to this situation. Christopher Halse Rogers goes on CC as he is the gapless author.
Created attachment 174137 [details] New logfile. Here's a logfile with gapless playback disabled. I let it run for 6 songs or so.
Hrmm if gapless is disabled I wonder why this appears in the log. [1 Debug 14:59:27.417] (libbanshee:player) [gapless] Triggering track-change signal
I was able to verify this problem (thanks to dnielsen), but my log differs (no html returned). Anyway, i noticed that StreamError is actually a 403 Forbidden error, returned by lastfm e.g. if one plays the track in the wrong order. The problem seems to be with gstreamer. The playlist is parsed correct, further all stream locations are downloadable (sequential, of course). The interesting fact about lastfm's stations: If you start to download/buffer the next song, it instantly terminates the old connection. So my assumption is that gapless starts to download the new song, the old one is terminated and gstreamer trys to reconnect to the old one, thus invalidating the whole playlist. This is just an assumption based on my observations, i was not able to verify this with wireshark (plain capture of the whole conversation), but it seems quite reasonable.
*** Bug 639000 has been marked as a duplicate of this bug. ***
*** Bug 649733 has been marked as a duplicate of this bug. ***
*** Bug 651951 has been marked as a duplicate of this bug. ***
This bug hasn't seen any real action in more than a year, and with Banshee 2.2.1 it all seems to be working fine. I will close this bug since I opened it, but if anyone feels the need to reopen it please feel free. Thank you all for your help!