$ banshee-1 --debug
** Running Mono with --debug   **
[1 Info  12:40:00.552] Running Banshee 1.7.5: [source-tarball (linux-gnu, x86_64) @ 2010-09-04 17:12:27 PDT]
[1 Debug 12:40:00.767] Initializing GTK
pp SCAN: SetupDomain
[1 Debug 12:40:04.789] Post-Initializing GTK
[1 Debug 12:40:04.877] Configuration client extension loaded (Banshee.GnomeBackend.GConfConfigurationClient)
[1 Debug 12:40:04.929] Using default gconf-base-key
[1 Debug 12:40:05.153] Bus.Session.RequestName ('org.bansheeproject.Banshee') replied with PrimaryOwner
[1 Debug 12:40:05.336] Core service started (DBusServiceManager, 0.002127)
[1 Debug 12:40:05.340] Registering remote object /org/bansheeproject/Banshee/DBusCommandService (Banshee.ServiceStack.DBusCommandService) on org.bansheeproject.Banshee
[1 Debug 12:40:05.353] Core service started (DBusCommandService, 0.016776)
[1 Debug 12:40:09.565] Opened SQLite (version 3.6.23.1) connection to /home/michael/.config/banshee-1/banshee.db
[1 Debug 12:40:09.567] Core service started (DbConnection, 4.21321)
[1 Debug 12:40:09.585] Database version 43 is up to date
[1 Info  12:40:09.835] Starting collection of anonymous usage data
[1 Debug 12:40:10.006] Core service started (PreferenceService, 0.11859)
[1 Debug 12:40:10.008] Registering remote object /org/bansheeproject/Banshee/SourceManager (Banshee.Sources.SourceManager) on org.bansheeproject.Banshee
[1 Debug 12:40:10.009] Core service started (SourceManager, 0.002458)
[1 Debug 12:40:10.044] Core service started (MediaProfileManager, 0.001265)
[1 Debug 12:40:10.062] Registering remote object /org/bansheeproject/Banshee/PlayerEngine (Banshee.MediaEngine.PlayerEngineService) on org.bansheeproject.Banshee
[1 Debug 12:40:10.068] Core service started (PlayerEngine, 0.024581)
[1 Debug 12:40:10.270] Registering remote object /org/bansheeproject/Banshee/PlaybackController (Banshee.PlaybackController.PlaybackControllerService) on org.bansheeproject.Banshee
[1 Debug 12:40:10.274] Core service started (PlaybackController, 0.009641)
[1 Debug 12:40:10.301] Starting - Startup Job
[1 Debug 12:40:10.303] Core service started (JobScheduler, 0.02865)
[1 Debug 12:40:10.361] IO provider extension loaded (Banshee.IO.Unix.Provider)
[1 Debug 12:40:10.390] Loaded HardwareManager backend: Banshee.HalBackend.HardwareManager
[1 Debug 12:40:10.397] Core service started (HardwareManager, 0.09379)
[1 Debug 12:40:10.406] Bus.Session.RequestName ('org.bansheeproject.CollectionIndexer') replied with PrimaryOwner
[1 Debug 12:40:10.417] Registering remote object /org/bansheeproject/Banshee/CollectionIndexerService (Banshee.Collection.Indexer.CollectionIndexerService) on org.bansheeproject.CollectionIndexer
[1 Debug 12:40:10.423] Core service started (CollectionIndexerService, 0.025533)
[1 Debug 12:40:10.431] Core service started (SaveTrackMetadataService, 0.007479)
[1 Debug 12:40:10.513] Adding icon theme search path: /usr/local/share/banshee-1/icons
[1 Debug 12:40:10.518] Core service started (GtkElementsService, 0.087008)
[1 Debug 12:40:10.537] Core service started (InterfaceActionService, 0.018746)
[1 Debug 12:40:10.831] Extension actions loaded: MetadataFixActions
[1 Debug 12:40:10.831] Registering remote object /org/bansheeproject/Banshee/GlobalUIActions (Banshee.Gui.GlobalActions) on org.bansheeproject.Banshee
[1 Debug 12:40:10.834] Album artwork path set to /home/michael/.cache/media-art
[1 Debug 12:40:10.936] Core service started (ArtworkManager, 0.104242)
[1 Debug 12:40:10.936] Core service started (BookmarksService, 0.000276)
[1 Debug 12:40:11.970] Adding context page lastfm-recommendations
[1 Debug 12:40:12.623] Constructed Nereid interface: 1.297617
[1 Debug 12:40:12.898] Creating new surface cache for 90px images, capped at 0.37 MiB (12 items)
[1 Debug 12:40:13.427] Registering remote object /org/bansheeproject/Banshee/ClientWindow (Nereid.PlayerInterface) on org.bansheeproject.Banshee
[1 Debug 12:40:13.427] Core service started (NereidPlayerInterface, 2.490752)
[1 Debug 12:40:13.564] Extension service started (GStreamerCoreService, 0.135898)
[1 Debug 12:40:13.615] Extension service started (BpmService, 0.050451)
[1 Debug 12:40:13.641] Using GNOME 2.22 API for Multimedia Keys
[1 Debug 12:40:13.642] Extension service started (MultimediaKeysService, 0.026721)
[1 Debug 12:40:13.644] Extension service started (LibraryWatcherService, 0.002563)
[1 Debug 12:40:13.650] Extension service started (PodcastService, 0.005238)
[1 Debug 12:40:13.652] Extension service started (DapService, 0.002084)
[1 Debug 12:40:13.654] Extension service started (DaapService, 0.001828)
[1 Info  12:40:13.660] Updating web proxy from GConf
[1 Debug 12:40:13.673] Direct connection, no proxy in use
[1 Debug 12:40:13.697] Extension service started (GnomeService, 0.043494)
[1 Debug 12:40:13.786] Core service started (Network, 0.024349)
[1 Debug 12:40:13.786] Audioscrobbler state: connected
[1 Debug 12:40:13.790] Extension service started (AudioscrobblerService, 0.092134)
[1 Debug 12:40:13.794] Extension service started (AmazonMp3DownloaderService, 0.004445)
[1 Debug 12:40:13.876] Extension service started (NotificationAreaService, 0.081943)
[1 Debug 12:40:13.881] Extension service started (CoverArtService, 0.00506)
[1 Debug 12:40:14.011] Extension service started (AudioCdService, 0.129342)
[1 Info  12:40:14.013] All services are started 8.856308
[1 Debug 12:40:19.601] Registering remote object /org/bansheeproject/Banshee/SourceManager/PlayQueue (Banshee.PlayQueue.PlayQueueSource) on org.bansheeproject.Banshee
[1 Debug 12:40:19.602] Extension source loaded: Play Queue
[1 Debug 12:40:19.614] Extension source loaded: Now Playing
[1 Debug 12:40:19.656] Extension source loaded: Last.fm
[1 Debug 12:40:19.714] Extension source loaded: Audiobooks, etc
[1 Debug 12:40:19.725] Starting GTK main loop
[1 Debug 12:40:19.894] Growing surface cache for 90px images to 0.65 MiB (21 items)
[1 Debug 12:40:20.166] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 12:40:20.283] Creating Pango.Layout, configuring Cairo.Context
[1 Debug 12:40:20.344] Creating Pango.Layout, configuring Cairo.Context
[1 Info  12:40:20.662] nereid Client Started
[1 Debug 12:40:20.670] Delayed Initializating Banshee.MediaEngine.PlayerEngineService
[1 Debug 12:40:20.760] (libbanshee:player) Stream volume supported: YES
[1 Debug 12:40:20.799] (libbanshee:player) Audiosink has volume: NO
[1 Debug 12:40:20.833] (libbanshee:player) Using built-in equalizer element
[1 Debug 12:40:21.067] Player state change: NotReady -> Ready
[1 Debug 12:40:21.085] Loaded equalizer presets: 0.000321
[1 Debug 12:40:21.100] Selected equalizer: Rock
[1 Debug 12:40:21.116] Player state change: Ready -> Idle
[1 Debug 12:40:21.134] (libbanshee:player) Enabled ReplayGain
[1 Debug 12:40:21.166] (libbanshee:player) scaled volume: 1.00 (ReplayGain) * 1.00 (User) = 1.00
[1 Debug 12:40:21.174] (libbanshee:player) scaled volume: 1.00 (ReplayGain) * 0.51 (User) = 0.51
[1 Debug 12:40:21.179] Delayed Initializating Banshee.LibraryWatcher.LibraryWatcherService
[1 Debug 12:40:21.193] Core service started (LibraryImportManager, 0.007447)
[1 Debug 12:40:21.211] Started LibraryWatcher for Music (/media/Passport/Audio/Music/)
[1 Debug 12:40:21.213] Started LibraryWatcher for Videos (/home/michael/Videos/)
[1 Debug 12:40:21.213] Delayed Initializating Banshee.Podcasting.PodcastService
[1 Debug 12:40:21.390] Delayed Initializating Banshee.Dap.DapService
[1 Debug 12:40:21.402] Dap support extension loaded: Banshee.Dap.MassStorage
[1 Debug 12:40:21.405] Dap support extension loaded: Banshee.Dap.AppleDevice
[1 Debug 12:40:21.409] Dap support extension loaded: Banshee.Dap.Mtp
[1 Debug 12:40:22.146] Delayed Initializating Banshee.Daap.DaapService
[2 Debug 12:40:22.151] Refreshing any podcasts that haven't been updated in over an hour
[3 Debug 12:40:22.710] DAAP Proxy listening for connections on port 8089
[1 Debug 12:40:23.222] Finished - Startup Job
[1 Debug 12:40:23.227] Starting - Saving Metadata to File
[4 Debug 12:40:23.271] Finished - Saving Metadata to File
[5 Debug 12:40:24.254] Found DAP support (Banshee.Dap.AppleDevice.AppleDeviceSource) for device iPod Nano 5.Gen and Uuid /org/freedesktop/Hal/devices/volume_uuid_3141_5926

** (Banshee:6394): WARNING **: Unknown action (0x2000400) in smart playlist will be ignored.


** (Banshee:6394): WARNING **: Unknown smart rule action at 119320: 2000400. Trying to continue.


** (Banshee:6394): WARNING **: Unknown action (0x2000400) in smart playlist will be ignored.


** (Banshee:6394): WARNING **: Unknown smart rule action at 120632: 2000400. Trying to continue.


** (Banshee:6394): WARNING **: Unknown action (0x2000400) in smart playlist will be ignored.


** (Banshee:6394): WARNING **: Unknown smart rule action at 121948: 2000400. Trying to continue.


** (Banshee:6394): WARNING **: Unknown action (0x2000400) in smart playlist will be ignored.


** (Banshee:6394): WARNING **: Unknown smart rule action at 123258: 2000400. Trying to continue.

[6 Warn  12:40:39.323] Error posting metrics - System.Net.WebException: The remote server returned an error: (503) Service Not Available. (in `System')
  at System.Net.HttpWebRequest.CheckFinalStatus (System.Net.WebAsyncResult result) [0x002b1] in /builddir/build/BUILD/mono-2.6.4/mcs/class/System/System.Net/HttpWebRequest.cs:1446 
  at System.Net.HttpWebRequest.SetResponseData (System.Net.WebConnectionData data) [0x00143] in /builddir/build/BUILD/mono-2.6.4/mcs/class/System/System.Net/HttpWebRequest.cs:1285 
[6 Info  12:40:39.323] Posted usage data? False
[1 Debug 12:43:54.728] Core service started (ImportSourceManager, 0.000709)
[1 Debug 12:44:18.843] Starting - Importing Media
[7 Debug 12:44:26.614] Importing Media duration: 7.772913
[7 Debug 12:44:26.615] Finished - Importing 1 of 1
[7 Debug 12:44:26.617] Starting - Downloading Cover Art
[8 Debug 12:44:26.754] Finished - Downloading Cover Art
[9 Debug 12:44:30.976] Starting
[9 Debug 12:44:31.450] Initialized MediaProfileManager: 0.393881
[9 Debug 12:44:31.516] GStreamer pipeline does not run: audioconvert ! novellaacenc bitrate=128000 profile=2 outputformat=0 ! novellqtmux
[9 Debug 12:44:31.735] GStreamer pipeline does not run: audioconvert ! xingenc bitrate=128 ! id3v2mux
[9 Debug 12:44:31.849] GStreamer pipeline does not run: audioconvert ! fluwmaenc bitrate=64000 vbr=false ! fluasfmux
[9 Debug 12:44:31.908] Finished - Adding 1 of 1 to iPod Nano 5.Gen
[10 Debug 12:44:32.089] Starting - Syncing iPod

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed
libitdbprep: itdb_sqlite_generate_itdbs called with file /media/BAILEY'S IP_/iPod_Control/iTunes/iTunesCDB and uuid 000A2700207A5646
itlp directory='/media/BAILEY'S IP_/iPod_Control/iTunes/iTunes Library.itlp'
*.itdb files will be stored in '/media/BAILEY'S IP_/iPod_Control/iTunes/iTunes Library.itlp'
[mk_Dynamic] Processing '/tmp/fileFaUfgC/Dynamic.itdb'
[mk_Dynamic] creating table structure
[mk_Dynamic] - processing 69 tracks
[mk_Dynamic] - processing 4 playlists
[mk_Dynamic] done.
[mk_Extras] Processing '/tmp/fileFaUfgC/Extras.itdb'
[mk_Extras] re-building table structure
[mk_Extras] done.
[mk_Genius] Processing '/tmp/fileFaUfgC/Genius.itdb'
[mk_Genius] re-building table structure
[mk_Genius] done.
library_persistent_id = 0xbcbfe39c50eae9c1
[mk_Library] Processing '/tmp/fileFaUfgC/Library.itdb'
[mk_Library] building table structure
[mk_Library] compiling SQL statements
[mk_Library] - inserting into "version_info"
[mk_Library] - inserting into "genre_map"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Bailey’s iPod' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Voice Memos' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Podcasts' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Music Library' into "container"
library_persistent_id = 0xbcbfe39c50eae9c1
device name = Bailey’s iPod
[mk_Library] - inserting into "db_info"
[mk_Library] - processing 69 tracks
[mk_Library] done.
[mk_Locations] Processing '/tmp/fileFaUfgC/Locations.itdb'
[mk_Locations] re-building table structure
[mk_Locations] Processing 69 tracks...
[mk_Locations] done.
[run_post_process_commands] Getting SQL post process commands
[run_post_process_commands] Running 88 post process commands now
[run_post_process_commands] ERROR when executing 'CreateRentalExpiredColumn': duplicate column name: rental_expired
[run_post_process_commands] 87 out of 88 post process commands successfully executed
[run_post_process_commands] done.
itdbprep: copying 'Dynamic.itdb'
itdbprep: copying 'Extras.itdb'
itdbprep: copying 'Genius.itdb'
itdbprep: copying 'Library.itdb'
itdbprep: copying 'Locations.itdb'
itdbprep: copying 'Locations.itdb.cbk'
[10 Info  12:44:34.369] Wrote iPod database
[10 Debug 12:44:34.369] Finished - Syncing iPod
[10 Debug 12:44:45.027] Starting - Syncing iPod

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): WARNING **: Unknown action type 33555456



** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed

** (Banshee:6394): CRITICAL **: itdb_splr_validate: assertion `at != ITDB_SPLAT_UNKNOWN' failed
libitdbprep: itdb_sqlite_generate_itdbs called with file /media/BAILEY'S IP_/iPod_Control/iTunes/iTunesCDB and uuid 000A2700207A5646
itlp directory='/media/BAILEY'S IP_/iPod_Control/iTunes/iTunes Library.itlp'
*.itdb files will be stored in '/media/BAILEY'S IP_/iPod_Control/iTunes/iTunes Library.itlp'
[mk_Dynamic] Processing '/tmp/file8xA40v/Dynamic.itdb'
[mk_Dynamic] creating table structure
[mk_Dynamic] - processing 69 tracks
[mk_Dynamic] - processing 4 playlists
[mk_Dynamic] done.
[mk_Extras] Processing '/tmp/file8xA40v/Extras.itdb'
[mk_Extras] re-building table structure
[mk_Extras] done.
[mk_Genius] Processing '/tmp/file8xA40v/Genius.itdb'
[mk_Genius] re-building table structure
[mk_Genius] done.
library_persistent_id = 0xbcbfe39c50eae9c1
[mk_Library] Processing '/tmp/file8xA40v/Library.itdb'
[mk_Library] building table structure
[mk_Library] compiling SQL statements
[mk_Library] - inserting into "version_info"
[mk_Library] - inserting into "genre_map"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Bailey’s iPod' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Voice Memos' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Podcasts' into "container"
[mk_Library] - inserting songs into "item_to_container"
[mk_Library] - inserting playlist 'Music Library' into "container"
library_persistent_id = 0xbcbfe39c50eae9c1
device name = Bailey’s iPod
[mk_Library] - inserting into "db_info"
[mk_Library] - processing 69 tracks
[mk_Library] done.
[mk_Locations] Processing '/tmp/file8xA40v/Locations.itdb'
[mk_Locations] re-building table structure
[mk_Locations] Processing 69 tracks...
[mk_Locations] done.
[run_post_process_commands] Getting SQL post process commands
[run_post_process_commands] Running 88 post process commands now
[run_post_process_commands] ERROR when executing 'CreateRentalExpiredColumn': duplicate column name: rental_expired
[run_post_process_commands] 87 out of 88 post process commands successfully executed
[run_post_process_commands] done.
itdbprep: copying 'Dynamic.itdb'
itdbprep: copying 'Extras.itdb'
itdbprep: copying 'Genius.itdb'
itdbprep: copying 'Library.itdb'
itdbprep: copying 'Locations.itdb'
itdbprep: copying 'Locations.itdb.cbk'
[10 Info  12:44:47.548] Wrote iPod database
[10 Debug 12:44:47.548] Finished - Syncing iPod
[1 Debug 12:44:47.721] Unmapping DAP source (/org/freedesktop/Hal/devices/volume_uuid_3141_5926)
[11 Warn  12:44:48.906] Caught an exception - System.Exception: org.freedesktop.Hal.Device.UnknownError: An unknown error occured (in `NDesk.DBus.Proxies')
  at IVolumeProxy.Eject (System.String[] ) [0x00000] in <filename unknown>:0 
  at Hal.Volume.Eject (System.String[] args) [0x00000] in /home/michael/Source/banshee-1-1.7.5/src/Backends/Banshee.Hal/Hal/Volume.cs:78 
  at Hal.Volume.Eject () [0x00000] in /home/michael/Source/banshee-1-1.7.5/src/Backends/Banshee.Hal/Hal/Volume.cs:73 
  at Banshee.HalBackend.Volume.Eject () [0x0001b] in /home/michael/Source/banshee-1-1.7.5/src/Backends/Banshee.Hal/Banshee.HalBackend/Volume.cs:156 
  at Banshee.Dap.AppleDevice.AppleDeviceSource.Eject () [0x00037] in /home/michael/Source/banshee-1-1.7.5/src/Dap/Banshee.Dap.AppleDevice/Banshee.Dap.AppleDevice/AppleDeviceSource.cs:123 
  at Banshee.Dap.RemovableSource.<Unmap>m__C (System.Object ) [0x00000] in /home/michael/Source/banshee-1-1.7.5/src/Dap/Banshee.Dap/Banshee.Dap/RemovableSource.cs:112 
[1 Debug 12:44:58.961] Service disposed (AudioCdService)
[1 Debug 12:44:58.966] Service disposed (CoverArtService)
[1 Debug 12:44:58.981] Service disposed (NotificationAreaService)
[1 Debug 12:44:58.985] Service disposed (AmazonMp3DownloaderService)
[1 Debug 12:44:58.993] Service disposed (AudioscrobblerService)
[1 Debug 12:44:58.994] Service disposed (Network)
[1 Debug 12:44:59.000] Service disposed (GnomeService)
[1 Debug 12:44:59.022] Service disposed (DaapService)
[1 Debug 12:44:59.073] Service disposed (DapService)
[1 Debug 12:44:59.121] Service disposed (PodcastService)
[1 Debug 12:44:59.173] Service disposed (LibraryWatcherService)
[1 Debug 12:44:59.181] Service disposed (MultimediaKeysService)
[1 Debug 12:44:59.183] Service disposed (BpmService)
[1 Debug 12:44:59.186] Service disposed (GStreamerCoreService)
[1 Debug 12:44:59.197] Service disposed (NereidPlayerInterface)
[1 Debug 12:44:59.198] Service disposed (BookmarksService)
[1 Debug 12:44:59.199] Service disposed (CollectionIndexerService)
[1 Debug 12:44:59.203] Service disposed (HardwareManager)
[1 Debug 12:44:59.208] (libbanshee:player) bp_stop: setting state to GST_STATE_NULL
[1 Debug 12:44:59.212] (libbanshee:player) bp_destroy: disposed player
[1 Debug 12:44:59.212] Service disposed (PlayerEngine)
[1 Debug 12:44:59.250] Service disposed (SourceManager)
[1 Debug 12:44:59.275] Service disposed (DbConnection)

