** Running Mono with --debug   **
[1 Debug 19:21:39.732] Bus.Session.RequestName ('org.bansheeproject.Banshee') replied with PrimaryOwner
[1 Info  19:21:39.748] Running Banshee 2.6.1: [Debian GNU/Linux unstable (sid) (linux-gnu, x86_64) @ 2013-06-05 21:04:48 MYT]
[1 Debug 19:21:39.755] Initializing GTK
[1 Debug 19:21:40.402] Post-Initializing GTK
[1 Debug 19:21:40.410] Configuration client extension loaded (Banshee.GnomeBackend.GConfConfigurationClient)
[1 Debug 19:21:40.412] Using default gconf-base-key
[1 Debug 19:21:40.463] Core service started (DBusServiceManager, 0.000967)
[1 Debug 19:21:40.465] Registering remote object /org/bansheeproject/Banshee/DBusCommandService (Banshee.ServiceStack.DBusCommandService) on org.bansheeproject.Banshee
[1 Debug 19:21:40.469] Core service started (DBusCommandService, 0.006096)
[1 Debug 19:21:40.486] Opened SQLite (version 3.7.17) connection to /home/broonie/.config/banshee-1/banshee.db
[1 Debug 19:21:40.487] Core service started (DbConnection, 0.017601)
[1 Debug 19:21:40.491] Database version 45 is up to date
[1 Debug 19:21:40.494] Running ANALYZE against database to improve performance
[1 Debug 19:21:40.512] Core service started (PreferenceService, 0.00815)
[1 Debug 19:21:40.516] Core service started (Network, 0.004112)
[1 Debug 19:21:40.516] Registering remote object /org/bansheeproject/Banshee/SourceManager (Banshee.Sources.SourceManager) on org.bansheeproject.Banshee
[1 Debug 19:21:40.516] Core service started (SourceManager, 0.00051)
[1 Debug 19:21:40.520] Core service started (MediaProfileManager, 0.0002)
[1 Debug 19:21:40.521] Registering remote object /org/bansheeproject/Banshee/PlayerEngine (Banshee.MediaEngine.PlayerEngineService) on org.bansheeproject.Banshee
[1 Debug 19:21:40.522] Core service started (PlayerEngine, 0.0028)
[1 Debug 19:21:40.531] Registering remote object /org/bansheeproject/Banshee/PlaybackController (Banshee.PlaybackController.PlaybackControllerService) on org.bansheeproject.Banshee
[1 Debug 19:21:40.532] Core service started (PlaybackController, 0.001639)
[1 Debug 19:21:40.535] Starting - Startup Job
[1 Debug 19:21:40.536] Core service started (JobScheduler, 0.00387)
[1 Debug 19:21:40.545] IO provider extension loaded (Banshee.IO.Gio.Provider)
[1 Debug 19:21:40.584] Loaded HardwareManager backend: Banshee.Hardware.Gio
[1 Debug 19:21:40.586] Core service started (HardwareManager, 0.049666)
[1 Debug 19:21:40.587] Bus.Session.RequestName ('org.bansheeproject.CollectionIndexer') replied with PrimaryOwner
[1 Debug 19:21:40.587] Registering remote object /org/bansheeproject/Banshee/CollectionIndexerService (Banshee.Collection.Indexer.CollectionIndexerService) on org.bansheeproject.CollectionIndexer
[1 Debug 19:21:40.588] Core service started (CollectionIndexerService, 0.00261)
[1 Debug 19:21:40.589] Core service started (SaveTrackMetadataService, 0.001089)
[1 Debug 19:21:40.594] Adding icon theme search path: /usr/share/banshee/icons
[1 Debug 19:21:40.594] Core service started (GtkElementsService, 0.004815)
[1 Debug 19:21:40.595] Core service started (InterfaceActionService, 0.000818)
[1 Debug 19:21:40.661] Extension actions loaded: MetadataFixActions
[1 Debug 19:21:40.661] Registering remote object /org/bansheeproject/Banshee/GlobalUIActions (Banshee.Gui.GlobalActions) on org.bansheeproject.Banshee
[1 Debug 19:21:40.662] Album artwork path set to /home/broonie/.cache/media-art
[1 Debug 19:21:40.672] Core service started (ArtworkManager, 0.011118)
[1 Debug 19:21:40.672] Core service started (BookmarksService, 0.000105)
[1 Debug 19:21:40.771] Adding context page lastfm-recommendations
[1 Debug 19:21:40.784] Adding context page wikipedia
[1 Debug 19:21:40.919] Constructed Nereid interface: 0.228064
[1 Debug 19:21:40.960] Creating new surface cache for 90px images, capped at 0.93 MiB (30 items)
[1 Debug 19:21:40.981] Registering remote object /org/bansheeproject/Banshee/ClientWindow (Nereid.PlayerInterface) on org.bansheeproject.Banshee
[1 Debug 19:21:40.981] Core service started (NereidPlayerInterface, 0.303065)
[1 Debug 19:21:40.983] Extension service started (DapService, 0.000932)
[1 Debug 19:21:41.004] Extension service started (EmusicService, 0.020897)
[1 Debug 19:21:41.007] Extension service started (DaapService, 0.002956)
[1 Debug 19:21:41.014] Using GNOME 2.22 API for Multimedia Keys
[1 Debug 19:21:41.014] Extension service started (MultimediaKeysService, 0.006706)
[1 Info  19:21:41.016] Updating web proxy from GConf
[1 Debug 19:21:41.019] Direct connection, no proxy in use
[1 Debug 19:21:41.030] Extension service started (GnomeService, 0.015562)
[1 Debug 19:21:41.042] Extension service started (GStreamerCoreService, 0.012458)
[1 Debug 19:21:41.044] Extension service started (uPnP Client service, 0.002028)
[1 Debug 19:21:41.059] Audioscrobbler state: connected
[1 Debug 19:21:41.060] Extension service started (AudioscrobblerService, 0.016086)
[1 Debug 19:21:41.062] Extension service started (AmazonMp3DownloaderService, 0.001367)
[1 Debug 19:21:41.066] Extension service started (MprisService, 0.004221)
[1 Warn  19:21:41.079] Failed to load media-player-info file for 1
[1 Debug 19:21:41.084] Extension service started (AudioCdService, 0.018249)
[1 Warn  19:21:41.085] Failed to load media-player-info file for 1
[1 Debug 19:21:41.086] Extension service started (DvdService, 0.001379)
[1 Debug 19:21:41.087] Extension service started (PodcastService, 0.001257)
[1 Debug 19:21:41.102] Extension service started (NotificationAreaService, 0.015273)
[1 Debug 19:21:41.104] Extension service started (CoverArtService, 0.001378)
[1 Debug 19:21:41.110] Extension service started (BpmService, 0.005487)
[1 Info  19:21:41.111] All services are started 0.683231
[1 Debug 19:21:41.314] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 19:21:41.365] Extension source loaded: Miro Guide
[1 Debug 19:21:41.367] Extension source loaded: Now Playing
[1 Debug 19:21:41.373] Extension source loaded: Radio
[1 Debug 19:21:41.387] Extension source loaded: Audiobooks
[1 Debug 19:21:41.401] Extension source loaded: Last.fm
[1 Info  19:21:41.403] AmazonMP3 store redirect URL: http://integrated-services.banshee.fm/amz/redirect.do/
[1 Debug 19:21:41.403] Extension source loaded: Amazon MP3 Store
[1 Debug 19:21:41.417] Extension source loaded: File System Queue
[1 Debug 19:21:41.422] Extension source loaded: Internet Archive
[1 Debug 19:21:41.478] Registering remote object /org/bansheeproject/Banshee/SourceManager/PlayQueue (Banshee.PlayQueue.PlayQueueSource) on org.bansheeproject.Banshee
[1 Debug 19:21:41.478] Extension source loaded: Play Queue
[1 Debug 19:21:41.481] Starting GTK main loop
[1 Debug 19:21:41.562] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 19:21:41.579] Creating Pango.Layout, configuring Cairo.Context
[1 Info  19:21:41.620] nereid Client Started
[1 Debug 19:21:41.622] Delayed Initializating Banshee.MediaEngine.PlayerEngineService
[1 Debug 19:21:41.631] (libbanshee:player) Audiosink has volume: YES
[1 Debug 19:21:41.637] (libbanshee:player) Using system (gst-plugins-good) equalizer element
[1 Debug 19:21:41.647] Player state change: NotReady -> Ready
[1 Debug 19:21:41.650] Loaded equalizer presets: 0.000163
[1 Debug 19:21:41.653] Selected equalizer: Rock
[1 Debug 19:21:41.655] Player state change: Ready -> Idle
[1 Debug 19:21:41.657] (libbanshee:player) Disabled ReplayGain
[1 Info  19:21:41.658] GStreamer version 1.0.7.0, gapless: True, replaygain: False
[1 Debug 19:21:41.660] Delayed Initializating Banshee.Dap.DapService
[1 Debug 19:21:41.664] Dap support extension loaded: Banshee.Dap.Mtp
[1 Debug 19:21:41.665] Dap support extension loaded: Banshee.Dap.AppleDevice
[1 Debug 19:21:41.665] Dap support extension loaded: Banshee.Dap.MassStorage
[1 Debug 19:21:41.666] Dap support extension loaded: Banshee.Dap.Karma
[1 Warn  19:21:41.667] Failed to load media-player-info file for 1
[1 Debug 19:21:41.670] Delayed Initializating Banshee.Daap.DaapService
[1 Debug 19:21:41.670] Delayed Initializating Banshee.UPnPClient.UPnPService
[7 Info  19:21:41.682] AppleDeviceSource is ignoring unmounted volume SAMSUNG_Android
[1 Debug 19:21:41.699] Delayed Initializating Banshee.Podcasting.PodcastService
[11 Debug 19:21:41.726] Refreshing any podcasts that haven't been updated in over an hour
[12 Debug 19:21:42.041] Found DAAP share My Music on damiel, trying to resolve...
[12 Debug 19:21:42.042] Found DAAP share My Music on damiel, trying to resolve...
[13 Debug 19:21:42.046] DAAP Proxy listening for connections on port 8089
[12 Debug 19:21:42.050] Managed to resolve DAAP share My Music on damiel.
[12 Debug 19:21:42.051] OnServiceResolved provided fe80::29c:2ff:fea7:f54a%2
[1 Debug 19:21:42.727] Finished - Startup Job
[1 Debug 19:21:42.729] Starting - Downloading Cover Art
[15 Debug 19:21:42.730] Finished - Downloading Cover Art
[12 Debug 19:21:43.041] Using address 10.0.1.138
[19 Debug 19:21:44.503] UPnPService.DeviceAdded (urn:schemas-upnp-org:device:MediaServer:1) uuid:4d696e69-444c-164e-9d41-009c02a7f54a
[12 Debug 19:21:45.336] Managed to resolve DAAP share My Music on damiel.
[12 Debug 19:21:45.336] OnServiceResolved provided 10.0.1.138
[12 Debug 19:21:45.336] Using address 10.0.1.138
[19 Debug 19:21:47.629] UPnPService MediaServer Found: Windows Media Connect compatible (MiniDLNA) 1
[19 Debug 19:21:47.630] UPnPService "Sirena Media" Implements urn:schemas-upnp-org:service:ContentDirectory:1
[19 Debug 19:21:48.155] UPnPService "Sirena Media" Implements urn:schemas-upnp-org:service:ConnectionManager:1
[19 Debug 19:21:48.155] UPnPService "Sirena Media" Implements urn:microsoft.com:service:X_MS_MediaReceiverRegistrar:1
[20 Debug 19:21:48.158] UPnPService.DeviceAdded (urn:linn-co-uk:device:Source:1) uuid:4c494e4e-0026-0f21-c33a-01309655013f
[20 Debug 19:21:48.647] UPnPService.DeviceAdded (urn:linn-co-uk:device:Source:1) uuid:4c494e4e-0026-0f21-ca3d-01317959013f
[21 Debug 19:21:48.700] Content directory is searchable, let's search
[20 Debug 19:21:48.756] UPnPService.DeviceAdded (urn:schemas-upnp-org:device:Basic:1) uuid:34567890-1234-1010-8000-5453ed72b287
[7 Debug 19:21:57.277] Found DAP support (Banshee.Dap.Mtp.MtpSource) for device GT-I9300 and Uuid /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2.1/1-1.2.1.4
[7 Info  19:21:57.279] AppleDeviceSource is ignoring unmounted volume PBR_DRV
[7 Info  19:21:57.284] AppleDeviceSource is ignoring unmounted volume LENOVO
[7 Info  19:21:57.288] AppleDeviceSource is ignoring unmounted volume WINRE_DRV
[7 Info  19:21:57.292] AppleDeviceSource is ignoring unmounted volume LRS_ESP
[38 Debug 19:22:24.662] UPnPService.DeviceAdded (urn:schemas-upnp-org:device:MediaServer:1) uuid:9cede6ff-d646-4040-92d6-ed1628271490
[38 Debug 19:22:27.305] UPnPService MediaServer Found: Windows Media Player Sharing 12.0
[38 Debug 19:22:27.305] UPnPService "NASTROND: broonie@sirena.org.uk:" Implements urn:schemas-upnp-org:service:ConnectionManager:1
[38 Debug 19:22:27.305] UPnPService "NASTROND: broonie@sirena.org.uk:" Implements urn:schemas-upnp-org:service:ContentDirectory:1
[38 Debug 19:22:27.811] UPnPService "NASTROND: broonie@sirena.org.uk:" Implements urn:microsoft.com:service:X_MS_MediaReceiverRegistrar:1
[46 Debug 19:22:28.276] Content directory is searchable, let's search
[46 Warn  19:22:30.324] Caught an exception - Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.DeserializationException: The DIDL-Lite element has no proper children. (in `Mono.Upnp.Dcp.MediaServer1')
  at Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.RemoteContentDirectory+<Deserialize>c__Iterator6`1[Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.Object].MoveNext () [0x00000] in <filename unknown>:0 
  at Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.RemoteContentDirectory.Deserialize[MusicTrack] (System.String xml) [0x00000] in <filename unknown>:0 
  at Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.RemoteContentDirectory.Search[MusicTrack] (Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.Container container, System.Action`1 query, ResultsSettings settings) [0x00000] in <filename unknown>:0 
  at Banshee.UPnPClient.UPnPServerSource.Parse (Mono.Upnp.Device device, Mono.Upnp.Dcp.MediaServer1.ContentDirectory1.ContentDirectoryController content_directory) [0x00000] in <filename unknown>:0 
[46 Debug 19:22:30.325] Found all items on the service, took 00:00:02.5132650
[1 Debug 19:22:30.362] Player state change: Idle -> Loading
[1 Debug 19:22:33.429] (libbanshee:player) [gapless] Triggering track-change signal
[1 Debug 19:22:33.441] Player state change: Loading -> Loaded
[1 Debug 19:22:33.450] Player state change: Loaded -> Playing
[1 Debug 19:22:33.455] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 19:22:33.455] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 19:22:34.450] TrackInfoDisplay RenderAnimation: 31.00 FPS
[1 Debug 19:22:35.688] TrackInfoDisplay RenderAnimation: 32.00 FPS
[1 Debug 19:22:36.840] TrackInfoDisplay RenderAnimation: 32.00 FPS
[52 Warn  19:22:43.451] Caught an exception - System.Net.WebException: The request timed out (in `System')
  at System.Net.HttpWebRequest.EndGetResponse (IAsyncResult asyncResult) [0x00000] in <filename unknown>:0 
  at System.Net.HttpWebRequest.GetResponse () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.GetHttpStream (System.Uri uri, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.GetHttpStream (System.Uri uri) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.Rhapsody.RhapsodyQueryJob.Run () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.Run () [0x00000] in <filename unknown>:0 
[1 Debug 19:22:44.394] TrackInfoDisplay RenderAnimation: 32.00 FPS
[49 Warn  19:22:46.869] Caught an exception - System.Net.WebException: The request timed out (in `System')
  at System.Net.HttpWebRequest.EndGetResponse (IAsyncResult asyncResult) [0x00000] in <filename unknown>:0 
  at System.Net.HttpWebRequest.GetResponse () [0x00000] in <filename unknown>:0 
  at Lastfm.LastfmRequest.Post (System.String uri, System.String data) [0x00000] in <filename unknown>:0 
[49 Warn  19:22:46.870] Audioscrobbler NowPlaying failed: Unknown
[1 Debug 19:22:51.550] TrackInfoDisplay RenderAnimation: 32.00 FPS
[1 Debug 19:23:00.912] TrackInfoDisplay RenderAnimation: 32.00 FPS
[52 Warn  19:23:02.910] Caught an exception - System.Net.WebException: The request timed out (in `System')
  at System.Net.HttpWebRequest.EndGetResponse (IAsyncResult asyncResult) [0x00000] in <filename unknown>:0 
  at System.Net.HttpWebRequest.GetResponse () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.GetHttpStream (System.Uri uri, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.SaveHttpStream (System.Uri uri, System.String path, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.SaveHttpStreamCover (System.Uri uri, System.String albumArtistId, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MusicBrainz.MusicBrainzQueryJob.SaveCover (System.String uri) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MusicBrainz.MusicBrainzQueryJob.Lookup () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MusicBrainz.MusicBrainzQueryJob.Run () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.Run () [0x00000] in <filename unknown>:0 
[1 Debug 19:23:10.758] TrackInfoDisplay RenderAnimation: 32.00 FPS
[52 Warn  19:23:16.636] Cover art found on Lastfm, but downloading it failed. Probably server under high load or dead link - System.Net.WebException: The request timed out (in `System')
  at System.Net.HttpWebRequest.EndGetResponse (IAsyncResult asyncResult) [0x00000] in <filename unknown>:0 
  at System.Net.HttpWebRequest.GetResponse () [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.GetHttpStream (System.Uri uri, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.SaveHttpStream (System.Uri uri, System.String path, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.MetadataServiceJob.SaveHttpStreamCover (System.Uri uri, System.String albumArtistId, System.String[] ignoreMimeTypes) [0x00000] in <filename unknown>:0 
  at Banshee.Metadata.LastFM.LastFMQueryJob.Run () [0x00000] in <filename unknown>:0 
[1 Debug 19:23:22.681] TrackInfoDisplay RenderAnimation: 32.00 FPS
[1 Debug 19:23:25.560] TrackInfoDisplay RenderAnimation: 32.00 FPS
[65 Debug 19:23:32.867] UPnPService.DeviceAdded (urn:schemas-upnp-org:device:MediaRenderer:1) uuid:4c494e4e-0026-0f21-ca3d-013179590171
