elisa log

colin@colinlaptop:~$ ELISA_DEBUG=5 elisa -t
DEBUG [14084]                                  log               Feb 04 16:49:08      ELISA_DEBUG set to *:2,5 (elisa/core/common.py:82)
DEBUG MainThread      log                         Feb 04 16:49:08  Integrating twisted logger (elisa/core/common.py:83)
LOG   MainThread      twisted                     Feb 04 16:49:08   [-] Log opened. (elisa/core/common.py:83)
DEBUG MainThread      application                 Feb 04 16:49:09  Creating (elisa/core/application.py:177)
INFO  MainThread      application                 Feb 04 16:49:09  Using config file: '/home/colin/.elisa/elisa.conf' (elisa/core/application.py:236)
INFO  MainThread      config                      Feb 04 16:49:09  Using '/home/colin/.elisa/elisa.conf' config file (elisa/core/config.py:79)
INFO  MainThread      config_upgrader             Feb 04 16:49:09  Trying to upgrade from 0.3.3 to 0.3.3 (elisa/core/config_upgrader.py:54)
INFO  MainThread      config_upgrader             Feb 04 16:49:09  No update needed (elisa/core/config_upgrader.py:81)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Creating (elisa/core/plugin_registry.py:97)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Plugin directory: '/home/colin/.elisa/plugins' (elisa/core/plugin_registry.py:148)
DEBUG MainThread      aggregator__plugin          Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/aggregator_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/aggregator_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      aggregator                  Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'aggregator' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'aggregator' plugin: podcatcher_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      album__art__plugin          Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/album_art_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/album_art_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      album_art                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'album_art' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'album_art' plugin: cover_cache, cover_in_dir (elisa/core/plugin_registry.py:196)
DEBUG MainThread      amazon__plugin              Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/amazon_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/amazon_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      amazon                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'amazon' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'amazon' plugin: amazon_covers (elisa/core/plugin_registry.py:196)
DEBUG MainThread      aspect__ratio__switcher     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/aspect_ratio_switcher/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/aspect_ratio_switcher/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/good/aspect_ratio_switcher/i18n for domain elisa-aspect-ratio-switcher (elisa/extern/translation.py:157)
DEBUG MainThread      aspect_ratio_switcher       Feb 04 16:49:09  Adding elisa-aspect-ratio-switcher to domain /usr/lib/python2.5/site-packages/elisa/plugins/good/aspect_ratio_switcher/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      aspect_ratio_switcher       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'aspect_ratio_switcher' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'aspect_ratio_switcher' plugin: aspect_ratio_switcher_activity, switch_aspect_action (elisa/core/plugin_registry.py:196)
DEBUG MainThread      audiocd                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd/i18n for domain elisa-audiocd (elisa/extern/translation.py:157)
DEBUG MainThread      audiocd                     Feb 04 16:49:09  Adding elisa-audiocd to domain /usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      audiocd                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'audiocd' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'audiocd' plugin: audiocd_media, cdda_engine (elisa/core/plugin_registry.py:196)
DEBUG MainThread      base                        Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/base/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/base/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/base/i18n for domain elisa-base (elisa/extern/translation.py:157)
DEBUG MainThread      base                        Feb 04 16:49:09  Adding elisa-base to domain /usr/lib/python2.5/site-packages/elisa/plugins/base/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      base                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'base' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'base' plugin: default_playlist, eject_action, elisa_model, empty_theme, enqueue_action, list_model, local_media, menu_activity, menu_model, menu_node_model, node_model, play_action, playbin_engine, player_activity, player_controller, player_model, player_view, preview_image_action, preview_play_action, raw_input, service_activity, slideshow_action, slideshow_activity, slideshow_controller, slideshow_model, slideshow_view, tree_model, view_image_action (elisa/core/plugin_registry.py:196)
DEBUG MainThread      bluetooth__plugin           Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/bluetooth_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/bluetooth_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      bluetooth                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'bluetooth' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'bluetooth' plugin: bluetooth_input (elisa/core/plugin_registry.py:196)
DEBUG MainThread      coherence__plugin           Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin/i18n for domain elisa-bad-coherence (elisa/extern/translation.py:157)
DEBUG MainThread      coherence                   Feb 04 16:49:09  Adding elisa-bad-coherence to domain /usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      coherence                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'coherence' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'coherence' plugin: coherence_service, upnp_media, upnp_media_renderer, upnp_media_server (elisa/core/plugin_registry.py:196)
DEBUG MainThread      daap__plugin                Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/daap_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/daap_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      daap                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'daap' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'daap' plugin: daap_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      dvd                         Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd/i18n for domain elisa-dvd (elisa/extern/translation.py:157)
DEBUG MainThread      dvd                         Feb 04 16:49:09  Adding elisa-dvd to domain /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      dvd                         Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'dvd' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'dvd' plugin: dvd_activity, dvd_player_activity, dvd_player_controller, dvd_player_model, dvd_player_view, menu_action (elisa/core/plugin_registry.py:196)
DEBUG MainThread      flickr                      Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/flickr/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/flickr/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/ugly/flickr/i18n for domain elisa-flickr (elisa/extern/translation.py:157)
DEBUG MainThread      flickr                      Feb 04 16:49:09  Adding elisa-flickr to domain /usr/lib/python2.5/site-packages/elisa/plugins/ugly/flickr/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      flickr                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'flickr' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'flickr' plugin: flickr_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      fspot                       Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/fspot/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/fspot/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      fspot                       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'fspot' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'fspot' plugin: fspot_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      gnome__plugin               Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/gnome_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/gnome_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      gnome                       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'gnome' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'gnome' plugin: gnome_screensaver_service (elisa/core/plugin_registry.py:196)
DEBUG MainThread      gstreamer__plugin           Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/gstreamer_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/gstreamer_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      gstreamer                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'gstreamer' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'gstreamer' plugin: gst_metadata, gst_metadata_client (elisa/core/plugin_registry.py:196)
DEBUG MainThread      gtk__frontend               Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/gtk_frontend/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/gtk_frontend/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/bad/gtk_frontend/i18n for domain elisa-gtk-frontend (elisa/extern/translation.py:157)
DEBUG MainThread      gtk                         Feb 04 16:49:09  Adding elisa-gtk-frontend to domain /usr/lib/python2.5/site-packages/elisa/plugins/bad/gtk_frontend/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      gtk                         Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'gtk' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'gtk' plugin: gtk_context, gtk_list_view, gtk_node_view, gtk_player_view, gtk_startup_view, gtk_tree_view (elisa/core/plugin_registry.py:196)
DEBUG MainThread      gvfs__plugin                Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/gvfs_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/gvfs_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      gvfs                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'gvfs' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'gvfs' plugin: gnomevfs_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      hal                         Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/hal/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/hal/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/good/hal/i18n for domain elisa-hal-service (elisa/extern/translation.py:157)
DEBUG MainThread      hal                         Feb 04 16:49:09  Adding elisa-hal-service to domain /usr/lib/python2.5/site-packages/elisa/plugins/good/hal/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      hal                         Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'hal' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'hal' plugin: hal_service (elisa/core/plugin_registry.py:196)
DEBUG MainThread      helper__frontend            Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/helper_frontend/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/helper_frontend/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      helper                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'helper' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'helper' plugin: glade_context, helper_startup_view (elisa/core/plugin_registry.py:196)
DEBUG MainThread      httpd__plugin               Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/httpd_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/httpd_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      httpd                       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'httpd' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'httpd' plugin: http_server (elisa/core/plugin_registry.py:196)
DEBUG MainThread      ipod__plugin                Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/ipod_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/ipod_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      ipod                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'ipod' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'ipod' plugin: ipod_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      lastfm__plugin              Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/lastfm_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/lastfm_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      lastfm                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'lastfm' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'lastfm' plugin: lastfm_scrobbler (elisa/core/plugin_registry.py:196)
DEBUG MainThread      lirc__plugin                Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/lirc_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/lirc_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      lirc                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'lirc' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'lirc' plugin: lirc_input (elisa/core/plugin_registry.py:196)
DEBUG MainThread      media__db                   Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/media_db/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/media_db/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      media_db                    Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'media_db' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'media_db' plugin: elisa_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      osso                        Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/osso/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/osso/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      osso                        Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'osso' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'osso' plugin: osso_service (elisa/core/plugin_registry.py:196)
DEBUG MainThread      pigment                     Feb 04 16:49:09  Loading config from file '/usr/lib/python2.5/site-packages/elisa/plugins/good/pigment/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using '/usr/lib/python2.5/site-packages/elisa/plugins/good/pigment/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      pigment                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'pigment' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'pigment' plugin: fadein_transition, fadeout_transition, pigment_context, pigment_input, pigment_transition, pigment_view (elisa/core/plugin_registry.py:196)
DEBUG MainThread      poblenou__frontend          Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/poblenou_frontend/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/poblenou_frontend/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      poblenou                    Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'poblenou' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'poblenou' plugin: dvd_player_view, elisa_view, node_controller, node_view, player_view, slideshow_view, tree_controller, tree_view, zoomin_transition, zoomout_transition (elisa/core/plugin_registry.py:196)
DEBUG MainThread      raval__frontend             Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      raval                       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'raval' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'raval' plugin: chris_theme, context_controller, context_model, context_view, coverflow_list_controller, coverflow_list_view, coverflow_view_mode_action, detailed_shaded_list_view, elisa_activity, elisa_controller, elisa_view, focus_transition, grid_controller, grid_view, grid_view_mode_action, list_controller, list_view, list_view_mode_action, location_controller, location_model, location_view, main_menu_controller, main_menu_view, manager_controller, manager_model, manager_view, player_in_transition, player_out_transition, poblenou_theme, preview, shaded_list_view, show_player_action, stop_playing_action, tango_theme, unfocus_transition (elisa/core/plugin_registry.py:196)
DEBUG MainThread      rhythmbox                   Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/rhythmbox/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/rhythmbox/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      rhythmbox                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'rhythmbox' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'rhythmbox' plugin: rb_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      service                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/service/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/service/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/service/i18n for domain elisa-service (elisa/extern/translation.py:157)
DEBUG MainThread      service                     Feb 04 16:49:09  Adding elisa-service to domain /usr/lib/python2.5/site-packages/elisa/plugins/service/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      service                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'service' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'service' plugin: about_activity (elisa/core/plugin_registry.py:196)
DEBUG MainThread      shoutcast__plugin           Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/shoutcast_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/shoutcast_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      shoutcast                   Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'shoutcast' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'shoutcast' plugin: shoutcast_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      stage6                      Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/stage6/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/stage6/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/ugly/stage6/i18n for domain elisa-stage6 (elisa/extern/translation.py:157)
DEBUG MainThread      stage6                      Feb 04 16:49:09  Adding elisa-stage6 to domain /usr/lib/python2.5/site-packages/elisa/plugins/ugly/stage6/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      stage6                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'stage6' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'stage6' plugin: stage_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      testing                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/testing/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/testing/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      testing                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'testing' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'testing' plugin: automated_input, file_descriptor_monitor, threads_monitor (elisa/core/plugin_registry.py:196)
DEBUG MainThread      theme__switcher             Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/theme_switcher/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/theme_switcher/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/good/theme_switcher/i18n for domain elisa-theme-switcher (elisa/extern/translation.py:157)
DEBUG MainThread      theme_switcher              Feb 04 16:49:09  Adding elisa-theme-switcher to domain /usr/lib/python2.5/site-packages/elisa/plugins/good/theme_switcher/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      theme_switcher              Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'theme_switcher' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'theme_switcher' plugin: switch_theme_action, theme_switcher_activity (elisa/core/plugin_registry.py:196)
DEBUG MainThread      twisted__plugin             Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/twisted_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/twisted_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      twisted                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'twisted' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'twisted' plugin: twisted_pb (elisa/core/plugin_registry.py:196)
DEBUG MainThread      weather                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/weather/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/weather/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      weather                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'weather' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'weather' plugin: weather_activity, weather_controller, weather_gtk_view, weather_model, weather_pgm_view (elisa/core/plugin_registry.py:196)
DEBUG MainThread      webcam__plugin              Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/webcam_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/webcam_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      webcam                      Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'webcam' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'webcam' plugin: webcam_input (elisa/core/plugin_registry.py:196)
DEBUG MainThread      webtv__plugin               Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/webtv_plugin/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/webtv_plugin/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/bad/webtv_plugin/i18n for domain elisa-base (elisa/extern/translation.py:157)
DEBUG MainThread      webtv                       Feb 04 16:49:09  Adding elisa-base to domain /usr/lib/python2.5/site-packages/elisa/plugins/bad/webtv_plugin/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      webtv                       Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'webtv' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'webtv' plugin: mmslist_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      xmlmenu                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      xmlmenu                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'xmlmenu' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'xmlmenu' plugin: activity_node_builder, clearplaylist_action, enqueue_action, locations_builder, menu_entry_builder, menu_node_builder, play_action, playlist_node_builder, spawn_process_action, uri_node_builder, videoplay_action, viewimage_action, xdg_entry_builder, xmltreemenu_activity (elisa/core/plugin_registry.py:196)
DEBUG MainThread      youtube                     Feb 04 16:49:09  Loading config from file u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/youtube/plugin.conf' (elisa/core/plugin.py:190)
INFO  MainThread      config                      Feb 04 16:49:09  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/ugly/youtube/plugin.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      translator                  Feb 04 16:49:09  Adding localedir /usr/lib/python2.5/site-packages/elisa/plugins/ugly/youtube/i18n for domain elisa-youtube (elisa/extern/translation.py:157)
DEBUG MainThread      youtube                     Feb 04 16:49:09  Adding elisa-youtube to domain /usr/lib/python2.5/site-packages/elisa/plugins/ugly/youtube/i18n (elisa/core/plugin.py:253)
DEBUG MainThread      youtube                     Feb 04 16:49:09  Initializing (elisa/core/plugin.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Loaded the plugin 'youtube' (elisa/core/plugin_registry.py:190)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Components available in 'youtube' plugin: youtube_media (elisa/core/plugin_registry.py:196)
DEBUG MainThread      bus                         Feb 04 16:49:09  Creating (elisa/core/bus/bus.py:64)
DEBUG MainThread      service_manager             Feb 04 16:49:09  Creating (elisa/core/manager.py:61)
DEBUG MainThread      metadata_manager            Feb 04 16:49:09  Creating (elisa/core/manager.py:61)
DEBUG MainThread      media_manager               Feb 04 16:49:09  Creating (elisa/core/manager.py:61)
DEBUG MainThread      media_scanner               Feb 04 16:49:09  Creating (elisa/core/media_scanner.py:100)
INFO  MainThread      db_backend                  Feb 04 16:49:09  Using 'pysqlite2.dbapi2' database backend on '/home/colin/.elisa/elisa.db' database (elisa/core/db_backend.py:108)
DEBUG MainThread      db_backend                  Feb 04 16:49:09  QUERY: select version from core_meta (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:09  SQL request took 0.000837087631226 seconds (elisa/core/db_backend.py:209)
DEBUG MainThread      input_manager               Feb 04 16:49:09  Creating (elisa/core/manager.py:61)
DEBUG MainThread      interface_controller        Feb 04 16:49:09  Creating (elisa/core/interface_controller.py:62)
DEBUG MainThread      application                 Feb 04 16:49:09  Initializing manager <elisa.core.service_manager.ServiceManager object at 0x8a707ec> (elisa/core/application.py:381)
DEBUG MainThread      application                 Feb 04 16:49:09  Initializing manager <elisa.core.metadata_manager.MetadataManager object at 0x8a7082c> (elisa/core/application.py:381)
DEBUG MainThread      application                 Feb 04 16:49:09  Initializing manager <elisa.core.media_manager.MediaManager object at 0x8a7092c> (elisa/core/application.py:381)
DEBUG MainThread      application                 Feb 04 16:49:09  Initializing manager <elisa.core.input_manager.InputManager object at 0x8a708ec> (elisa/core/application.py:381)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Trying to create 'gnome:gnome_screensaver_service' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      gnome                       Feb 04 16:49:09  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Found plugin 'gnome', searching for Component 'gnome_screensaver_service' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      gnome                       Feb 04 16:49:09  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      gnome                       Feb 04 16:49:09  Checking dependencies: ['dbus'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Imported <class 'gnome_plugin.gnome_screensaver_service.GnomeScreensaverService'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/gnome_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:09  Instantiating Component 'gnome_screensaver_service' from 'gnome' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_gnome_screensaver_service Feb 04 16:49:09  Component gnome_screensaver_service is loading its config (elisa/core/component.py:308)
INFO  MainThread      comp_gnome_screensaver_service Feb 04 16:49:09  Using full-block mode (elisa/plugins/bad/gnome_plugin/gnome_screensaver_service.py:72)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Component gnome_screensaver_service loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      service_manager             Feb 04 16:49:09  Loaded provider gnome_screensaver_service (elisa/core/manager.py:86)
DEBUG MainThread      service_manager             Feb 04 16:49:09  Registering component gnome:gnome_screensaver_service (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Trying to create 'daap:daap_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      daap                        Feb 04 16:49:09  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Found plugin 'daap', searching for Component 'daap_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      daap                        Feb 04 16:49:09  Checking dependencies: ['daap'] (elisa/core/component.py:210)
DEBUG MainThread      daap                        Feb 04 16:49:09  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Imported <class 'daap_plugin.daap_media.DaapMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/daap_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:09  Instantiating Component 'daap_media' from 'daap' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_daap_media             Feb 04 16:49:09  Component daap_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Component daap_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:09  Loaded provider daap_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:09  Registering component daap:daap_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Trying to create 'hal:hal_service' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      hal                         Feb 04 16:49:09  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Found plugin 'hal', searching for Component 'hal_service' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      hal                         Feb 04 16:49:09  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      hal                         Feb 04 16:49:09  Checking dependencies: ['dbus'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Imported <class 'hal.hal_service.HalService'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/hal (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:09  Instantiating Component 'hal_service' from 'hal' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_hal_service            Feb 04 16:49:09  Component hal_service is loading its config (elisa/core/component.py:308)
DEBUG MainThread      bus                         Feb 04 16:49:09  Registering callback <bound method HalService._components_loaded of <hal.hal_service.HalService object at 0x8b4c28c>> for (<class 'elisa.core.bus.bus_message.ComponentsLoaded'>,) message types (elisa/core/bus/bus.py:140)
DEBUG MainThread      bus                         Feb 04 16:49:09  Registering callback <bound method HalService._device_action of <hal.hal_service.HalService object at 0x8b4c28c>> for (<class 'elisa.core.bus.bus_message.DeviceAction'>,) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      plugin_registry             Feb 04 16:49:09  Component hal_service loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      service_manager             Feb 04 16:49:09  Loaded provider hal_service (elisa/core/manager.py:86)
DEBUG MainThread      service_manager             Feb 04 16:49:09  Registering component hal:hal_service (elisa/core/manager.py:166)
INFO  MainThread      comp_daap_media             Feb 04 16:49:09  New DAAP share at 192.168.0.100:3689 : Colin's Library (elisa/plugins/bad/daap_plugin/daap_media.py:287)
DEBUG MainThread      bus                         Feb 04 16:49:09  Sending message <MediaLocation LOCATION_ADDED Colin's Library daap://192.168.0.100:3689/> (elisa/core/bus/bus.py:116)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Trying to create 'coherence:coherence_service' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      coherence                   Feb 04 16:49:09  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:09  Found plugin 'coherence', searching for Component 'coherence_service' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      coherence                   Feb 04 16:49:09  Checking dependencies: ['coherence >= 0.4.0'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'coherence_plugin.coherence_service.CoherenceService'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'coherence_service' from 'coherence' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_coherence_service      Feb 04 16:49:10  Component coherence_service is loading its config (elisa/core/component.py:308)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] <class 'coherence.upnp.core.ssdp.SSDPServer'> starting on 1900 (twisted/internet/udp.py:98)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] Starting protocol <coherence.upnp.core.ssdp.SSDPServer object at 0x8d5cfcc> (twisted/internet/protocol.py:473)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] <class 'coherence.upnp.core.msearch.MSearch'> starting on 51659 (twisted/internet/udp.py:98)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] Starting protocol <coherence.upnp.core.msearch.MSearch object at 0x8d6e5cc> (twisted/internet/protocol.py:473)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] coherence.upnp.core.utils.Site starting on 34708 (twisted/internet/tcp.py:739)
DEBUG MainThread      bus                         Feb 04 16:49:10  Registering callback <bound method CoherenceService._got_message of <coherence_plugin.coherence_service.CoherenceService object at 0x8b4fe2c>> for (<class 'elisa.core.bus.bus_message.CoherencePlugin'>, <class 'elisa.core.bus.bus_message.CoherenceDevice'>) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component coherence_service loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      service_manager             Feb 04 16:49:10  Loaded provider coherence_service (elisa/core/manager.py:86)
DEBUG MainThread      service_manager             Feb 04 16:49:10  Registering component coherence:coherence_service (elisa/core/manager.py:166)
INFO  MainThread      comp_daap_media             Feb 04 16:49:10  New DAAP share at 192.168.0.103:3689 : good shit (elisa/plugins/bad/daap_plugin/daap_media.py:287)
DEBUG MainThread      bus                         Feb 04 16:49:10  Sending message <MediaLocation LOCATION_ADDED good shit daap://192.168.0.103:3689/> (elisa/core/bus/bus.py:116)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'gstreamer:gst_metadata_client' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      gstreamer                   Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'gstreamer', searching for Component 'gst_metadata_client' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'gstreamer_plugin.gst_metadata.GstMetadataClient'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/gstreamer_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'gst_metadata_client' from 'gstreamer' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_gst_metadata_client    Feb 04 16:49:10  Component gst_metadata_client is loading its config (elisa/core/component.py:308)
INFO  MainThread      gst_metadata_client_process_launcher Feb 04 16:49:10  starting metadata server (elisa/plugins/good/gstreamer_plugin/gst_metadata.py:876)
DEBUG MainThread      gst_metadata_client_process_launcher Feb 04 16:49:10  metadata process started (elisa/plugins/good/gstreamer_plugin/gst_metadata.py:893)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component gst_metadata_client still loading (elisa/core/plugin_registry.py:493)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'youtube:youtube_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      youtube                     Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'youtube', searching for Component 'youtube_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      youtube                     Feb 04 16:49:10  Checking dependencies: ['gdata'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'youtube.youtube_media.YoutubeMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/ugly/youtube (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'youtube_media' from 'youtube' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_youtube_media          Feb 04 16:49:10  Component youtube_media is loading its config (elisa/core/component.py:308)
WARN  MainThread      media_manager               Feb 04 16:49:10  Component youtube_media failed to initialize: Can't initialize flvdemux CVS version of gst-plugins-bad (elisa/core/manager.py:95)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'shoutcast:shoutcast_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      shoutcast                   Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'shoutcast', searching for Component 'shoutcast_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      shoutcast                   Feb 04 16:49:10  Checking dependencies: ['elisa.extern.coherence.et'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'shoutcast_plugin.shoutcast_media.ShoutcastMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/ugly/shoutcast_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'shoutcast_media' from 'shoutcast' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_shoutcast_media        Feb 04 16:49:10  Component shoutcast_media is loading its config (elisa/core/component.py:308)
DEBUG MainThread      bus                         Feb 04 16:49:10  Sending message <MediaLocation LOCATION_ADDED Shoutcast shoutcast:///> (elisa/core/bus/bus.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component shoutcast_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider shoutcast_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component shoutcast:shoutcast_media (elisa/core/manager.py:166)
DEBUG MainThread      input_manager               Feb 04 16:49:10  Loaded 0 input_providers (elisa/core/manager.py:114)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'fspot:fspot_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      fspot                       Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'fspot', searching for Component 'fspot_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      fspot                       Feb 04 16:49:10  Checking supported platforms: ['linux'] (elisa/core/component.py:184)
DEBUG MainThread      fspot                       Feb 04 16:49:10  Checking dependencies: ['pysqlite2'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'fspot.fspot_media.FspotMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/fspot (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'fspot_media' from 'fspot' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_fspot_media            Feb 04 16:49:10  Component fspot_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      db_backend                  Feb 04 16:49:10  Using 'pysqlite2.dbapi2' database backend on '/home/colin/.gnome2/f-spot/photos.db' database (elisa/core/db_backend.py:108)
DEBUG MainThread      db_backend                  Feb 04 16:49:10  QUERY: select data from meta where name=? params=('F-Spot Database Version',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:10  SQL request took 0.000735998153687 seconds (elisa/core/db_backend.py:209)
DEBUG MainThread      comp_fspot_media            Feb 04 16:49:10  Found a F-Spot DB with version 6 at '/home/colin/.gnome2/f-spot/photos.db' (elisa/plugins/good/fspot/fspot_media.py:138)
DEBUG MainThread      bus                         Feb 04 16:49:10  Sending message <MediaLocation LOCATION_ADDED F-Spot fspot:///> (elisa/core/bus/bus.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component fspot_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider fspot_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component fspot:fspot_media (elisa/core/manager.py:166)
DEBUG MainThread      service_manager             Feb 04 16:49:10  Loaded 3 service_providers (elisa/core/manager.py:114)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'coherence:upnp_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'coherence', searching for Component 'upnp_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'coherence_plugin.upnp_media.UPnPMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/coherence_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'upnp_media' from 'coherence' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_upnp_media             Feb 04 16:49:10  Component upnp_media is loading its config (elisa/core/component.py:308)
DEBUG MainThread      bus                         Feb 04 16:49:10  Registering callback <bound method UPnPMedia._bus_message_received of <coherence_plugin.upnp_media.UPnPMedia object at 0x8de752c>> for (<class 'elisa.core.bus.bus_message.ComponentsLoaded'>,) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component upnp_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider upnp_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component coherence:upnp_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'ipod:ipod_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      ipod                        Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'ipod', searching for Component 'ipod_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      ipod                        Feb 04 16:49:10  Checking dependencies: ['gpod'] (elisa/core/component.py:210)
DEBUG MainThread      ipod                        Feb 04 16:49:10  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'ipod_plugin.ipod_media.IpodMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/ipod_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'ipod_media' from 'ipod' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_ipod_media             Feb 04 16:49:10  Component ipod_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component ipod_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider ipod_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component ipod:ipod_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'base:local_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      base                        Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'base', searching for Component 'local_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'base.local_media.LocalMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'local_media' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_local_media            Feb 04 16:49:10  Component local_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component local_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider local_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component base:local_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'media_db:elisa_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      media_db                    Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'media_db', searching for Component 'elisa_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'media_db.elisa_media.ElisaMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/media_db (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'elisa_media' from 'media_db' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_elisa_media            Feb 04 16:49:10  Component elisa_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component elisa_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider elisa_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component media_db:elisa_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'gvfs:gnomevfs_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      gvfs                        Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'gvfs', searching for Component 'gnomevfs_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      gvfs                        Feb 04 16:49:10  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      gvfs                        Feb 04 16:49:10  Checking dependencies: ['gnomevfs'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'gvfs_plugin.gnomevfs_media.GnomevfsMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/gvfs_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'gnomevfs_media' from 'gvfs' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_gnomevfs_media         Feb 04 16:49:10  Component gnomevfs_media is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component gnomevfs_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider gnomevfs_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component gvfs:gnomevfs_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'audiocd:audiocd_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      audiocd                     Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'audiocd', searching for Component 'audiocd_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'audiocd.audiocd_media.AudiocdMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'audiocd_media' from 'audiocd' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_audiocd_media          Feb 04 16:49:10  Component audiocd_media is loading its config (elisa/core/component.py:308)
DEBUG MainThread      bus                         Feb 04 16:49:10  Registering callback <bound method AudiocdMedia._bus_message_received of <audiocd.audiocd_media.AudiocdMedia object at 0x9026eac>> for (<class 'elisa.core.bus.bus_message.MediaLocation'>,) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component audiocd_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider audiocd_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component audiocd:audiocd_media (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'flickr:flickr_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      flickr                      Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'flickr', searching for Component 'flickr_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      flickr                      Feb 04 16:49:10  Checking dependencies: ['elisa.extern.flickrest', 'twill >= 0.9b1'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Imported <class 'flickr.flickr_media.FlickrMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/ugly/flickr (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:10  Instantiating Component 'flickr_media' from 'flickr' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_flickr_media           Feb 04 16:49:10  Component flickr_media is loading its config (elisa/core/component.py:308)
DEBUG MainThread      comp_flickr_media           Feb 04 16:49:10  Connected, None (elisa/plugins/ugly/flickr/flickr_media.py:83)
DEBUG MainThread      bus                         Feb 04 16:49:10  Sending message <MediaLocation LOCATION_ADDED flickr flickr:///> (elisa/core/bus/bus.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:10  Component flickr_media loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      media_manager               Feb 04 16:49:10  Loaded provider flickr_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:10  Registering component flickr:flickr_media (elisa/core/manager.py:166)
DEBUG [14095]                                  log               Feb 04 16:49:10      ELISA_DEBUG set to *:2,5 (elisa/core/common.py:82)
DEBUG MainThread      log                         Feb 04 16:49:10  Integrating twisted logger (elisa/core/common.py:83)
LOG   MainThread      twisted                     Feb 04 16:49:10   [-] Log opened. (elisa/core/common.py:83)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Trying to create 'stage6:stage_media' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      stage6                      Feb 04 16:49:10  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:10  Found plugin 'stage6', searching for Component 'stage_media' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      stage6                      Feb 04 16:49:10  Checking dependencies: ['BeautifulSoup'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'stage6.stage_media.StageMedia'> from /usr/lib/python2.5/site-packages/elisa/plugins/ugly/stage6 (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'stage_media' from 'stage6' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_stage_media            Feb 04 16:49:11  Component stage_media is loading its config (elisa/core/component.py:308)
DEBUG MainThread      bus                         Feb 04 16:49:11  Sending message <MediaLocation LOCATION_ADDED Stage6 stage6:///> (elisa/core/bus/bus.py:116)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component stage_media still loading (elisa/core/plugin_registry.py:493)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component stage_media loaded (elisa/core/plugin_registry.py:489)
LOG   MainThread      media_manager               Feb 04 16:49:11  Loaded provider stage_media (elisa/core/manager.py:86)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Registering component stage6:stage_media (elisa/core/manager.py:166)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Loaded 11 media_providers (elisa/core/manager.py:114)
DEBUG MainThread      gst_metadata_client_process_launcher Feb 04 16:49:11  initializing remote component (elisa/plugins/good/gstreamer_plugin/gst_metadata.py:853)
INFO  MainThread      gst_metadata_client_process_launcher Feb 04 16:49:11  metadata server started (elisa/plugins/good/gstreamer_plugin/gst_metadata.py:861)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component gst_metadata_client loaded (elisa/core/plugin_registry.py:489)
LOG   MainThread      metadata_manager            Feb 04 16:49:11  Loaded provider gst_metadata_client (elisa/core/manager.py:86)
DEBUG MainThread      metadata_manager            Feb 04 16:49:11  Registering component gstreamer:gst_metadata_client (elisa/core/manager.py:166)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'amazon:amazon_covers' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      amazon                      Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'amazon', searching for Component 'amazon_covers' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      amazon                      Feb 04 16:49:11  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      amazon                      Feb 04 16:49:11  Checking dependencies: ['elisa.extern.coherence.et'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'amazon_plugin.amazon_metadata.AmazonCovers'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/amazon_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'amazon_covers' from 'amazon' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_amazon_covers          Feb 04 16:49:11  Component amazon_covers is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component amazon_covers loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      metadata_manager            Feb 04 16:49:11  Loaded provider amazon_covers (elisa/core/manager.py:86)
DEBUG MainThread      metadata_manager            Feb 04 16:49:11  Registering component amazon:amazon_covers (elisa/core/manager.py:166)
DEBUG MainThread      metadata_manager            Feb 04 16:49:11  Loaded 2 metadata_providers (elisa/core/manager.py:114)
INFO  MainThread      player_engine_registry      Feb 04 16:49:11  Initializing (elisa/core/player_engine_registry.py:55)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:playbin_engine' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'playbin_engine' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playbin_engine.PlaybinEngine'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme ftp (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme http (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme daap (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme cdda (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme mms (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme sftp (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme file (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Adding base:playbin_engine for scheme smb (elisa/core/player_engine_registry.py:92)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'audiocd:cdda_engine' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'audiocd', searching for Component 'cdda_engine' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:playbin_engine' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'playbin_engine' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playbin_engine.PlaybinEngine'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'audiocd.cdda_engine.CddaEngine'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/audiocd (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:playbin_engine' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'playbin_engine' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playbin_engine.PlaybinEngine'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      player_engine_registry      Feb 04 16:49:11  Replacing base:playbin_engine with audiocd:cdda_engine for scheme cdda (elisa/core/player_engine_registry.py:88)
DEBUG MainThread      player_registry             Feb 04 16:49:11  Creating new player (elisa/core/player_registry.py:76)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method Player._new_clock of <elisa.core.player.Player object at 0x8b4fd0c>> for (<class 'elisa.core.player.NewClock'>,) message types (elisa/core/bus/bus.py:140)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method Player._new_base_time of <elisa.core.player.Player object at 0x8b4fd0c>> for (<class 'elisa.core.player.NewBaseTime'>,) message types (elisa/core/bus/bus.py:140)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method Player._engine_stopped of <elisa.core.player.Player object at 0x8b4fd0c>> for (<class 'elisa.core.player.PlayerStopping'>,) message types (elisa/core/bus/bus.py:140)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method Player._engine_error of <elisa.core.player.Player object at 0x8b4fd0c>> for (<class 'elisa.core.player.PlayerError'>,) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      player_registry             Feb 04 16:49:11  Initializing (elisa/core/player_registry.py:62)
INFO  MainThread      interface_controller        Feb 04 16:49:11  Initializing (elisa/core/interface_controller.py:112)
DEBUG MainThread      interface_controller        Feb 04 16:49:11  Initializing backend backend1 (elisa/core/interface_controller.py:151)
INFO  MainThread      config                      Feb 04 16:49:11  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' config file (elisa/core/config.py:79)
DEBUG MainThread      backend                     Feb 04 16:49:11  Setting controller None as root controller (elisa/core/backend.py:61)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:elisa_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      raval                       Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'elisa_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      raval                       Feb 04 16:49:11  Checking dependencies: ['pgm >= 0.3.0.1'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.elisa_activity.ElisaActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'elisa_activity' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_elisa_activity         Feb 04 16:49:11  Component elisa_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component elisa_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:elisa_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'elisa_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.elisa_model.ElisaModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'elisa_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_elisa_model            Feb 04 16:49:11  Component elisa_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component elisa_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:player_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.activities.player_activity.PlayerActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'player_activity' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_player_activity        Feb 04 16:49:11  Component player_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component player_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:player_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.player_model.PlayerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'player_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_player_model           Feb 04 16:49:11  Component player_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component player_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:default_playlist' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'default_playlist' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playlists.default_playlist.DefaultPlaylist'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'default_playlist' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_default_playlist       Feb 04 16:49:11  Component default_playlist is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component default_playlist loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      bus                         Feb 04 16:49:11  Sending message <elisa.core.bus.bus_message.PlayerModel object at 0x92c338c> (elisa/core/bus/bus.py:116)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'dvd:dvd_player_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      dvd                         Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'dvd', searching for Component 'dvd_player_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'dvd.dvd_player_activity.DvdPlayerActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'dvd_player_activity' from 'dvd' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_dvd_player_activity    Feb 04 16:49:11  Component dvd_player_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component dvd_player_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'dvd:dvd_player_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'dvd', searching for Component 'dvd_player_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:player_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.player_model.PlayerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'dvd.dvd_player_model.DvdPlayerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'dvd_player_model' from 'dvd' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_dvd_player_model       Feb 04 16:49:11  Component dvd_player_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component dvd_player_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:default_playlist' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'default_playlist' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playlists.default_playlist.DefaultPlaylist'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'default_playlist' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_default_playlist       Feb 04 16:49:11  Component default_playlist is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component default_playlist loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:slideshow_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'slideshow_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.activities.slideshow_activity.SlideshowActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'slideshow_activity' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_slideshow_activity     Feb 04 16:49:11  Component slideshow_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component slideshow_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:slideshow_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'slideshow_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.slideshow_model.SlideshowModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'slideshow_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_slideshow_model        Feb 04 16:49:11  Component slideshow_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component slideshow_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:default_playlist' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'default_playlist' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.playlists.default_playlist.DefaultPlaylist'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'default_playlist' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_default_playlist       Feb 04 16:49:11  Component default_playlist is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component default_playlist loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:xmltreemenu_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      xmlmenu                     Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'xmltreemenu_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      xmlmenu                     Feb 04 16:49:11  Checking dependencies: ['elisa.extern.coherence.et'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmltreemenu_activity.XmltreemenuActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'xmltreemenu_activity' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_xmltreemenu_activity   Feb 04 16:49:11  Component xmltreemenu_activity is loading its config (elisa/core/component.py:308)
DEBUG MainThread      comp_xmltreemenu_activity   Feb 04 16:49:11  Trying to load XML file: /home/colin/.elisa/elisa_menu.xml  (elisa/plugins/good/xmlmenu/xmltreemenu_activity.py:62)
INFO  MainThread      comp_xmltreemenu_activity   Feb 04 16:49:11  Could not read /home/colin/.elisa/elisa_menu.xml: [Errno 2] No such file or directory: '/home/colin/.elisa/elisa_menu.xml' (elisa/plugins/good/xmlmenu/xmltreemenu_activity.py:66)
INFO  MainThread      comp_xmltreemenu_activity   Feb 04 16:49:11  Using default menu description (elisa/plugins/good/xmlmenu/xmltreemenu_activity.py:67)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:activity_node_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'activity_node_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.activity_node_builder.ActivityNodeBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'activity_node_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_activity_node_builder  Feb 04 16:49:11  Component activity_node_builder is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component activity_node_builder loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:locations_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'locations_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.locations_builder.LocationsBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'locations_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Component locations_builder is loading its config (elisa/core/component.py:308)
DEBUG MainThread      list_observable             Feb 04 16:49:11  Adding observer <xmlmenu.xmlmenu_components.locations_builder.MediaManagerInformer object at 0x92e6d4c> (elisa/core/observers/list.py:231)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  XDG variables not found in os.environ, loading '/home/colin/.config/user-dirs.dirs' (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:268)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DESKTOP_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOWNLOAD_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_TEMPLATES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PUBLICSHARE_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOCUMENTS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_MUSIC_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PICTURES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_VIDEOS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  XDG variables not found in os.environ, loading '/home/colin/.config/user-dirs.dirs' (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:268)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DESKTOP_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOWNLOAD_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_TEMPLATES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PUBLICSHARE_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOCUMENTS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_MUSIC_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PICTURES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_VIDEOS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  XDG variables not found in os.environ, loading '/home/colin/.config/user-dirs.dirs' (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:268)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DESKTOP_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOWNLOAD_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_TEMPLATES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PUBLICSHARE_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_DOCUMENTS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_MUSIC_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_PICTURES_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Found XDG variable XDG_VIDEOS_DIR, injecting in os.environ (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:275)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Videos',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.000582933425903 seconds (elisa/core/db_backend.py:209)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
INFO  MainThread      media_scanner               Feb 04 16:49:11  Scheduling update of file:///home/colin/Videos (elisa/core/media_scanner.py:307)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Videos',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.00037693977356 seconds (elisa/core/db_backend.py:209)
LOG   MainThread      media_scanner               Feb 04 16:49:11  enqueing file:///home/colin/Videos file:///home/colin/Videos {} (elisa/core/media_scanner.py:328)
LOG   MainThread      media_scanner               Feb 04 16:49:11  1 items in queue (elisa/core/media_scanner.py:330)
INFO  MainThread      comp_locations_builder      Feb 04 16:49:11  Added file:///home/colin/Videos (['video']) (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:303)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Pictures',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.000370979309082 seconds (elisa/core/db_backend.py:209)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
INFO  MainThread      media_scanner               Feb 04 16:49:11  Scheduling update of file:///home/colin/Pictures (elisa/core/media_scanner.py:307)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Pictures',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.000381946563721 seconds (elisa/core/db_backend.py:209)
LOG   MainThread      media_scanner               Feb 04 16:49:11  enqueing file:///home/colin/Pictures file:///home/colin/Pictures {} (elisa/core/media_scanner.py:328)
LOG   MainThread      media_scanner               Feb 04 16:49:11  2 items in queue (elisa/core/media_scanner.py:330)
INFO  MainThread      comp_locations_builder      Feb 04 16:49:11  Added file:///home/colin/Pictures (['image']) (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:303)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Music',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.000370025634766 seconds (elisa/core/db_backend.py:209)
DEBUG MainThread      media_manager               Feb 04 16:49:11  Using 'local_media' media_provider to access file:// (elisa/core/media_manager.py:378)
INFO  MainThread      media_scanner               Feb 04 16:49:11  Scheduling update of file:///home/colin/Music (elisa/core/media_scanner.py:307)
DEBUG MainThread      db_backend                  Feb 04 16:49:11  QUERY: select * from core_source where uri=? params=(u'file:///home/colin/Music',) (elisa/core/db_backend.py:222)
LOG   MainThread      db_backend                  Feb 04 16:49:11  SQL request took 0.00037693977356 seconds (elisa/core/db_backend.py:209)
LOG   MainThread      media_scanner               Feb 04 16:49:11  enqueing file:///home/colin/Music file:///home/colin/Music {} (elisa/core/media_scanner.py:328)
LOG   MainThread      media_scanner               Feb 04 16:49:11  3 items in queue (elisa/core/media_scanner.py:330)
INFO  MainThread      comp_locations_builder      Feb 04 16:49:11  Added file:///home/colin/Music (['audio']) (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:303)
DEBUG MainThread      comp_locations_builder      Feb 04 16:49:11  Loaded Locations: <ListObservable '[<xmlmenu.xmlmenu_components.locations_builder.Location object at 0x92ed48c>, <xmlmenu.xmlmenu_components.locations_builder.Location object at 0x92ed5ac>, <xmlmenu.xmlmenu_components.locations_builder.Location object at 0x92ed6cc>]'> (elisa/plugins/good/xmlmenu/xmlmenu_components/locations_builder.py:313)
DEBUG MainThread      bus                         Feb 04 16:49:11  Sending message <elisa.core.bus.bus_message.LocationsList object at 0x92e6dac> (elisa/core/bus/bus.py:116)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method LocationsBuilder._got_bus_message of <xmlmenu.xmlmenu_components.locations_builder.LocationsBuilder object at 0x92e6ccc>> for (<class 'elisa.core.bus.bus_message.MediaLocation'>,) message types (elisa/core/bus/bus.py:140)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component locations_builder loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:xdg_entry_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'xdg_entry_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      xmlmenu                     Feb 04 16:49:11  Checking dependencies: ['xdg'] (elisa/core/component.py:210)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.xdg_entry_builder.XdgEntryBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'xdg_entry_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_xdg_entry_builder      Feb 04 16:49:11  Component xdg_entry_builder is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component xdg_entry_builder loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:playlist_node_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'playlist_node_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.playlist_node_builder.PlaylistNodeBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'playlist_node_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:clearplaylist_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'clearplaylist_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.actions.clearplaylist_action.ClearplaylistAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'clearplaylist_action' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_clearplaylist_action   Feb 04 16:49:11  Component clearplaylist_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component clearplaylist_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      default                     Feb 04 16:49:11  Component playlist_node_builder is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component playlist_node_builder loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:menu_node_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'menu_node_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.menu_node_builder.MenuNodeBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Component menu_node_builder is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_builder loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'xmlmenu:uri_node_builder' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'xmlmenu', searching for Component 'uri_node_builder' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'xmlmenu.xmlmenu_components.uri_node_builder.UriNodeBuilder'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/xmlmenu (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'uri_node_builder' from 'xmlmenu' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_uri_node_builder       Feb 04 16:49:11  Component uri_node_builder is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component uri_node_builder loaded (elisa/core/plugin_registry.py:498)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component xmltreemenu_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_model.MenuModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_model             Feb 04 16:49:11  Component menu_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:manager_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'manager_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.manager_model.ManagerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'manager_model' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_manager_model          Feb 04 16:49:11  Component manager_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component manager_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:location_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'location_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.location_model.LocationModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'location_model' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_location_model         Feb 04 16:49:11  Component location_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component location_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:context_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'context_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:list_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.context_model.ContextModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'context_model' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_context_model          Feb 04 16:49:11  Component context_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component context_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:show_player_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'show_player_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.actions.show_player_action.ShowPlayerAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'show_player_action' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_show_player_action     Feb 04 16:49:11  Component show_player_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component show_player_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:stop_playing_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'stop_playing_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.actions.stop_playing_action.StopPlayingAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'stop_playing_action' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_stop_playing_action    Feb 04 16:49:11  Component stop_playing_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component stop_playing_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>, <base.models.menu_node_model.MenuNodeModel object at 0x93b496c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>, <base.models.menu_node_model.MenuNodeModel object at 0x93b496c>, <base.models.menu_node_model.MenuNodeModel object at 0x93b46ac>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:list_view_mode_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_view_mode_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.actions.list_view_mode_action.ListViewModeAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_view_mode_action' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_view_mode_action  Feb 04 16:49:11  Component list_view_mode_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_view_mode_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>, <base.models.menu_node_model.MenuNodeModel object at 0x93b496c>, <base.models.menu_node_model.MenuNodeModel object at 0x93b46ac>, <base.models.menu_node_model.MenuNodeModel object at 0x92edb2c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:coverflow_view_mode_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'coverflow_view_mode_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.actions.coverflow_view_mode_action.CoverflowViewModeAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'coverflow_view_mode_action' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_coverflow_view_mode_action Feb 04 16:49:11  Component coverflow_view_mode_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component coverflow_view_mode_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>, <base.models.menu_node_model.MenuNodeModel object at 0x93b496c>, <base.models.menu_node_model.MenuNodeModel object at 0x93b46ac>, <base.models.menu_node_model.MenuNodeModel object at 0x92edb2c>, <base.models.menu_node_model.MenuNodeModel object at 0x93ba22c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:grid_view_mode_action' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'grid_view_mode_action' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.actions.grid_view_mode_action.GridViewModeAction'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'grid_view_mode_action' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_grid_view_mode_action  Feb 04 16:49:11  Component grid_view_mode_action is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component grid_view_mode_action loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x92d47cc>, <base.models.menu_node_model.MenuNodeModel object at 0x93b496c>, <base.models.menu_node_model.MenuNodeModel object at 0x93b46ac>, <base.models.menu_node_model.MenuNodeModel object at 0x92edb2c>, <base.models.menu_node_model.MenuNodeModel object at 0x93ba22c>, <base.models.menu_node_model.MenuNodeModel object at 0x93ba1ac>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:elisa_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:elisa_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:elisa_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'elisa_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.elisa_controller.ElisaController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'elisa_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_elisa_controller       Feb 04 16:49:11  Component elisa_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:elisa_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'elisa_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.elisa_model.ElisaModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component elisa_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      backend                     Feb 04 16:49:11  Setting controller <raval_frontend.elisa_controller.ElisaController object at 0x93ba32c> as root controller (elisa/core/backend.py:61)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'lirc:lirc_input' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      lirc                        Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'lirc', searching for Component 'lirc_input' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      lirc                        Feb 04 16:49:11  Checking dependencies: ['pylirc'] (elisa/core/component.py:210)
DEBUG MainThread      lirc                        Feb 04 16:49:11  Checking supported platforms: ['linux', 'posix'] (elisa/core/component.py:184)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'lirc_plugin.lirc_input.LircInput'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/lirc_plugin (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'lirc_input' from 'lirc' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_lirc_input             Feb 04 16:49:11  Component lirc_input is loading its config (elisa/core/component.py:308)
DEBUG MainThread      comp_lirc_input             Feb 04 16:49:11  Written 18 delays and 18 repeats to /tmp/elisa_tmp_lirc_heTO1K.lirc (elisa/plugins/good/lirc_plugin/lirc_input.py:126)
elisa: could not connect to socket
elisa: No such file or directory
DEBUG MainThread      comp_lirc_input             Feb 04 16:49:11  Component lirc_input is saving its config (elisa/core/component.py:344)
WARN  MainThread      interface_controller        Feb 04 16:49:11  Component lirc_input failed to initialize: Unable to initialize lirc! (elisa/core/interface_controller.py:324)
DEBUG MainThread      interface_controller        Feb 04 16:49:11  Loaded and connected 0 input_providers (elisa/core/interface_controller.py:326)
DEBUG MainThread      input_manager               Feb 04 16:49:11  Couldn't connect to input provider 'lirc:lirc_input'. Signal 'sig_lirc:lirc_input' not found (elisa/core/input_manager.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:player_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'base:player_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:player_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:list_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.controllers.player_controller.PlayerController'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'player_controller' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_player_controller      Feb 04 16:49:11  Component player_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:player_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.player_model.PlayerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component player_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:list_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:list_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:list_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.list_controller.ListController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_controller        Feb 04 16:49:11  Component list_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:list_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Adding observer <ListController current_index=0 0 items> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_player_model           Feb 04 16:49:11  Adding observer <base.controllers.player_controller.PlayerController object at 0x93c526c> (elisa/core/observers/observable.py:44)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'raval:manager_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:manager_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:manager_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'manager_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.manager_controller.ManagerController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'manager_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_manager_controller     Feb 04 16:49:11  Component manager_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:manager_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'manager_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.manager_model.ManagerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component manager_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'raval:location_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:location_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:location_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'location_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:list_controller' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.list_controller.ListController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.location_controller.LocationController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'location_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_location_controller    Feb 04 16:49:11  Component location_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:location_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'location_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.location_model.LocationModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component location_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_location_model         Feb 04 16:49:11  Adding observer <LocationController current_index=0 0 items> (elisa/core/observers/observable.py:44)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'raval:context_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:context_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:context_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'context_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:list_controller' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.list_controller.ListController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.context_controller.ContextController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'context_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_context_controller     Feb 04 16:49:11  Component context_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:context_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'context_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.context_model.ContextModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component context_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_context_model          Feb 04 16:49:11  Adding observer <ContextController current_index=0 6 items> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_manager_model          Feb 04 16:49:11  Adding observer <raval_frontend.manager_controller.ManagerController object at 0x93c5e8c> (elisa/core/observers/observable.py:44)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'dvd:dvd_player_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'dvd:dvd_player_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'dvd:dvd_player_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'dvd', searching for Component 'dvd_player_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:player_controller' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'player_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.controllers.player_controller.PlayerController'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'dvd.dvd_player_controller.DvdPlayerController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'dvd_player_controller' from 'dvd' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      bus                         Feb 04 16:49:11  Registering callback <bound method DvdPlayerController._got_bus_message of <dvd.dvd_player_controller.DvdPlayerController object at 0x93c5e6c>> for (<class 'elisa.core.bus.bus_message.DeviceAction'>,) message types (elisa/core/bus/bus.py:140)
DEBUG MainThread      comp_dvd_player_controller  Feb 04 16:49:11  Component dvd_player_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'dvd:dvd_player_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'dvd', searching for Component 'dvd_player_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'dvd.dvd_player_model.DvdPlayerModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/dvd (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component dvd_player_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:list_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:list_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:list_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.list_controller.ListController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_controller        Feb 04 16:49:11  Component list_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:list_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Adding observer <ListController current_index=0 0 items> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_dvd_player_model       Feb 04 16:49:11  Adding observer <dvd.dvd_player_controller.DvdPlayerController object at 0x93c5e6c> (elisa/core/observers/observable.py:44)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:slideshow_model' with content_type None (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'base:slideshow_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:slideshow_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'slideshow_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.controllers.slideshow_controller.SlideshowController'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'slideshow_controller' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_slideshow_controller   Feb 04 16:49:11  Component slideshow_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:slideshow_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'slideshow_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.slideshow_model.SlideshowModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component slideshow_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_slideshow_model        Feb 04 16:49:11  Adding observer <base.controllers.slideshow_controller.SlideshowController object at 0x93cd3ec> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_elisa_model            Feb 04 16:49:11  Adding observer <raval_frontend.elisa_controller.ElisaController object at 0x93ba32c> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_manager_controller     Feb 04 16:49:11  entering: <base.models.menu_model.MenuModel object at 0x92e698c> (elisa/plugins/bad/raval_frontend/manager_controller.py:139)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultFilesIcon to audio_file_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultDirsIcon to audio_directory_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting ContentType to audio (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting MediaFilter to audio (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultFilesIcon to video_file_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultDirsIcon to video_directory_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting ContentType to video (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting MediaFilter to video (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd84c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultFilesIcon to image_file_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting DefaultDirsIcon to image_directory_icon (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting ContentType to None (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting MediaFilter to image (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd84c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd88c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:service_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'service_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:menu_activity' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.activities.menu_activity.MenuActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.activities.service_activity.ServiceActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'service_activity' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_service_activity       Feb 04 16:49:11  Component service_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component service_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:menu_node_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:list_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'list_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Component list_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component list_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'service:about_activity' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      service                     Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'service', searching for Component 'about_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:menu_activity' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_activity' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.activities.menu_activity.MenuActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'service.about_activity.AboutActivity'> from /usr/lib/python2.5/site-packages/elisa/plugins/service (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'about_activity' from 'service' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_about_activity         Feb 04 16:49:11  Component about_activity is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component about_activity loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
LOG   MainThread      comp_service_activity       Feb 04 16:49:11  Component <service.about_activity.AboutActivity object at 0x93cdd0c> with menu model <base.models.menu_node_model.MenuNodeModel object at 0x93cdf0c> (elisa/plugins/base/activities/service_activity.py:58)
LOG   MainThread      comp_service_activity       Feb 04 16:49:11  menu model: <base.models.menu_node_model.MenuNodeModel object at 0x93cdf0c> (elisa/plugins/base/activities/service_activity.py:61)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cdf0c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd84c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd88c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cdbec>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_menu_node_builder      Feb 04 16:49:11  Setting ContentType to configuration (elisa/plugins/good/xmlmenu/xmlmenu_components/menu_entry_builder.py:108)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'base:menu_node_model' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'menu_node_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.menu_node_model.MenuNodeModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'menu_node_model' from 'base' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Component menu_node_model is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component menu_node_model loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_menu_node_model        Feb 04 16:49:11  Adding observer <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd84c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd88c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cdbec>, <base.models.menu_node_model.MenuNodeModel object at 0x93cdf2c>]'> (elisa/core/observers/observable.py:44)
DEBUG MainThread      comp_manager_controller     Feb 04 16:49:11  model returned by the activity: <ListObservable '[<base.models.menu_node_model.MenuNodeModel object at 0x93cd80c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd84c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cd88c>, <base.models.menu_node_model.MenuNodeModel object at 0x93cdbec>, <base.models.menu_node_model.MenuNodeModel object at 0x93cdf2c>]'> (elisa/plugins/bad/raval_frontend/manager_controller.py:145)
DEBUG MainThread      backend                     Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a controller for 'base:list_model' with content_type 'sections' (elisa/core/backend.py:143)
DEBUG MainThread      backend                     Feb 04 16:49:11  Found 'raval:main_menu_controller' (elisa/core/backend.py:159)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:main_menu_controller' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'main_menu_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:list_controller' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'list_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.list_controller.ListController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.main_menu_controller.MainMenuController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'main_menu_controller' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_main_menu_controller   Feb 04 16:49:11  Component main_menu_controller is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'base:list_model' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'base', searching for Component 'list_model' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'base.models.list_model.ListModel'> from /usr/lib/python2.5/site-packages/elisa/plugins/base (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component main_menu_controller loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_list_model             Feb 04 16:49:11  Adding observer <MainMenuController current_index=0 5 items> (elisa/core/observers/observable.py:44)
DEBUG MainThread      interface_controller        Feb 04 16:49:11  Initializing frontend frontend1 (elisa/core/interface_controller.py:216)
DEBUG MainThread      frontend                    Feb 04 16:49:11  Looking in u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/data/raval_mvc_mappings.conf' for a view for 'base:elisa_model' with content_type None (elisa/core/frontend.py:151)
DEBUG MainThread      frontend                    Feb 04 16:49:11  Found 'raval:elisa_view' (elisa/core/frontend.py:167)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:elisa_view' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'elisa_view' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'pigment:pigment_view' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      pigment                     Feb 04 16:49:11  Creating (elisa/core/plugin.py:105)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'pigment', searching for Component 'pigment_view' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'pigment.pigment_view.PigmentView'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/pigment (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.elisa_view.ElisaView'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'elisa_view' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:focus_transition' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'focus_transition' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'pigment:pigment_transition' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'pigment', searching for Component 'pigment_transition' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'pigment.pigment_transition.PigmentTransition'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/pigment (elisa/core/plugin_registry.py:568)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.transitions.FocusTransition'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'focus_transition' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_focus_transition       Feb 04 16:49:11  Component focus_transition is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component focus_transition loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:unfocus_transition' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'unfocus_transition' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.transitions.UnfocusTransition'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'unfocus_transition' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_unfocus_transition     Feb 04 16:49:11  Component unfocus_transition is loading its config (elisa/core/component.py:308)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component unfocus_transition loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      comp_elisa_view             Feb 04 16:49:11  Component elisa_view is loading its config (elisa/core/component.py:308)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Retrieving component class of 'raval:elisa_controller' (elisa/core/plugin_registry.py:583)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'elisa_controller' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.elisa_controller.ElisaController'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component elisa_view loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'raval:tango_theme' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'raval', searching for Component 'tango_theme' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'raval_frontend.tango_theme.tango_theme.TangoTheme'> from /usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'tango_theme' from 'raval' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_tango_theme            Feb 04 16:49:11  Component tango_theme is loading its config (elisa/core/component.py:308)
INFO  MainThread      config                      Feb 04 16:49:11  Using u'/usr/lib/python2.5/site-packages/elisa/plugins/bad/raval_frontend/tango_theme/tango_theme.conf' config file (elisa/core/config.py:79)
INFO  MainThread      plugin_registry             Feb 04 16:49:11  Component tango_theme loaded (elisa/core/plugin_registry.py:498)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Trying to create 'pigment:pigment_context' component (elisa/core/plugin_registry.py:459)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Found plugin 'pigment', searching for Component 'pigment_context' (elisa/core/plugin_registry.py:525)
DEBUG MainThread      plugin_registry             Feb 04 16:49:11  Imported <class 'pigment.pigment_context.PigmentContext'> from /usr/lib/python2.5/site-packages/elisa/plugins/good/pigment (elisa/core/plugin_registry.py:568)
LOG   MainThread      plugin_registry             Feb 04 16:49:11  Instantiating Component 'pigment_context' from 'pigment' (elisa/core/plugin_registry.py:475)
DEBUG MainThread      comp_pigment_context        Feb 04 16:49:11  Component pigment_context is loading its config (elisa/core/component.py:308)
INFO  MainThread      comp_pigment_context        Feb 04 16:49:11  Compiz not found (elisa/plugins/good/pigment/pigment_context.py:232)