Attachment 92522 Details for Bug 73881 – full log

full log

mc.log (text/plain), 234.12 KB, created by Guillaume Desmottes on 2014-01-21 15:43:30 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Guillaume Desmottes

Created: 2014-01-21 15:43:30 UTC

Size: 234.12 KB

patch

obsolete

>$ make -C tests/twisted check-twisted TWISTED_TESTS=account-storage/default-keyring-storage.py
>Testing account-storage/default-keyring-storage.py ...
>FAIL: account-storage/default-keyring-storage.py (1)
>===== log file: missioncontrol-24416.log =====
>(process:24416): mcd-DEBUG: telepathy-mission-control version 5.99.6+
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.lai is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:160 mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:160 fake-network-monitor.o isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:160 dbus-account-plugin.o isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-account-diversion.so, ...) = 0x1980450
>** (process:24416): DEBUG: Initializing mcp-account-diversion-plugin (n=0)
>** (process:24416): DEBUG: account_diversion_plugin_class_init
>** (process:24416): DEBUG: account_diversion_plugin_init
>** (process:24416): DEBUG: Initializing mcp-account-diversion-plugin (n=1)
>(process:24416): mc-plugins-DEBUG: loader.c:202 1 plugin object(s) found in mcp-account-diversion.so
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-plugin.o is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.lai isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.la is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.so isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.la isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.o is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-plugin.la is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:160 lt-mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24416): mc-plugins-DEBUG: loader.c:166 mcp-plugin.lai is not a loadable module
>(process:24416): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-plugin.so, ...) = 0x1980eb0
>** (process:24416): DEBUG: Initializing mcp-plugin (n=0)
>** (process:24416): DEBUG: Initializing mcp-plugin (n=1)
>** (process:24416): DEBUG: Initializing mcp-plugin (n=2)
>** (process:24416): DEBUG: Initializing mcp-plugin (n=3)
>** (process:24416): DEBUG: Initializing mcp-plugin (n=4)
>** (process:24416): DEBUG: test_dbus_account_plugin_class_init: called
>** (process:24416): DEBUG: test_dbus_account_plugin_init: called
>** (process:24416): DEBUG: Initializing mcp-plugin (n=5)
>(process:24416): mc-plugins-DEBUG: loader.c:202 5 plugin object(s) found in mcp-plugin.so
>(process:24416): mcd-DEBUG: mcd_service_init: called
>(process:24416): mcd-DEBUG: _mcd_account_manager_constructed: 
>** (process:24416): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24416): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24416): DEBUG: fake_network_monitor_class_init: enter
>** (process:24416): DEBUG: fake_network_monitor_init: enter
>(process:24416): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are offline
>(process:24416): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 2 -> 0; stable: 4 -> 4; running: 8 -> 8
>(process:24416): mcd-DEBUG: connectivity_monitor_change_states: disconnected
>(process:24416): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24416): mcd-DEBUG: plugin_iface_init: 
>(process:24416): mcd-DEBUG: _mcd_account_manager_constructed: loading plugins
>(process:24416): mcd-DEBUG: mcd_account_manager_default_class_init: mcd_account_manager_default_class_init
>(process:24416): mcd-DEBUG: mcd_account_manager_default_init: mcd_account_manager_default_init
>(process:24416): mcd-DEBUG: sort_and_cache_plugins: found plugin TestDBusAccount [TestDBusAccountPlugin; priority 200]
>Regression test plugin
>(process:24416): mcd-DEBUG: sort_and_cache_plugins: found plugin diverted-keyfile [AccountDiversionPlugin; priority 100]
>Test plugin that grabs all accounts it receives (except 'fakecm/fakeprotocol/dontdivert*') and diverts them to 'mcp-test-diverted-account-plugin.conf' in g_get_user_cache_dir () instead of the usual location.
>(process:24416): mcd-DEBUG: sort_and_cache_plugins: found plugin default [McdAccountManagerDefault; priority 0]
>Default account storage backend
>(process:24416): mc-plugins-DEBUG: account-storage.c:823: default: 
>(process:24416): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control': No such file or directory
>(process:24416): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control': No such file or directory
>(process:24416): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/mission-control': No such file or directory
>(process:24416): mcd-DEBUG: _list: Creating initial account data
>(process:24416): mcd-DEBUG: _list: Saving initial or migrated account data
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_storage_load: listing from plugin default [prio: 0]
>(process:24416): mc-plugins-DEBUG: account-storage.c:823: diverted-keyfile: 
>** (process:24416): DEBUG: checking for /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/cache/mcp-test-diverted-account-plugin.conf
>** (process:24416): DEBUG: created /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/cache/mcp-test-diverted-account-plugin.conf
>(process:24416): mcd-DEBUG: mcd_storage_load: listing from plugin diverted-keyfile [prio: 100]
>(process:24416): mc-plugins-DEBUG: account-storage.c:823: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_list: called
>(process:24416): mcd-DEBUG: mcd_storage_load: listing from plugin TestDBusAccount [prio: 200]
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal created 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal created 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal created 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal toggled 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal toggled 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal toggled 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal deleted 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal deleted 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal deleted 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal altered-one 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal altered-one 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal altered-one 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal reconnect 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal reconnect 
>(process:24416): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal reconnect 
>(process:24416): mcd-DEBUG: mcd_client_registry_constructed: Starting to look for clients
>(process:24416): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0x19649f0: org.freedesktop.DBus DBusGProxy is 0x19ab570
>(process:24416): mcd-DEBUG: mcd_account_manager_write_conf_async: updating all 0 accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: TestDBusAccount: committing all accounts
>** (process:24416): DEBUG: test_dbus_account_plugin_commit: called
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: default: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by TestDBusAccount
>** (process:24416): DEBUG: test_dbus_account_plugin_ready: called
>(process:24416): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by diverted-keyfile
>(process:24416): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by default
>(process:24416): mcd-DEBUG: release_load_accounts_lock: called, count is now 0
>(process:24416): mcd-DEBUG: mcd_service_constructed: called
>(process:24416): mcd-DEBUG: mcd_service_obtain_bus_name: Requesting MC dbus service
>(process:24416): mcd-DEBUG: Object Hierarchy of object 0x1960c20
>(process:24416): mcd-DEBUG: [
>(process:24416): mcd-DEBUG:     McdService (0x1960c20): 2
>(process:24416): mcd-DEBUG: ]
>** (process:24416): DEBUG: fake_network_monitor_get_properties_cb: Initial state: online
>** (process:24416): DEBUG: fake_network_monitor_set_state: New fake ConnMan network state online (an available state)
>** (process:24416): DEBUG: fake_network_monitor_set_state: notify::network-available
>** (process:24416): DEBUG: fake_network_monitor_emit_network_changed: available=1
>(process:24416): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are at least partially online
>(process:24416): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 0 -> 2; stable: 4 -> 4; running: 8 -> 8
>(process:24416): mcd-DEBUG: connectivity_monitor_change_states: connected
>(process:24416): mcd-DEBUG: mcd_client_registry_list_names_cb: ListNames returned
>(process:24416): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ChannelDispatcher,  -> :1.2)
>(process:24416): mcd-DEBUG: list_connection_names_cb: 0 connections
>(process:24416): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.AccountManager,  -> :1.2)
>(process:24416): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.MissionControl6,  -> :1.2)
>(process:24416): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24416): mcd-DEBUG: login1_inhibit_cb: unable to delay sleep and shutdown: g-dbus-error-quark #2: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.login1 was not provided by any .service files
>(process:24416): mcd-DEBUG: mcd_client_registry_list_activatable_names_cb: ListActivatableNames returned
>(process:24416): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.AbiWord
>(process:24416): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.AbiWord
>(process:24416): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24416): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 1 -> 2
>(process:24416): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.Logger
>(process:24416): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.Logger
>(process:24416): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24416): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 2 -> 3
>(process:24416): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 3 -> 2
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.AbiWord) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.AbiWord': no such name
>(process:24416): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.AbiWord: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/AbiWord.client
>(process:24416): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.AbiWord: im.telepathy.v1.Client.Handler
>(process:24416): mcd-DEBUG: mcd_client_proxy_introspect: im.telepathy.v1.Client.AbiWord is a Handler but not active
>(process:24416): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.AbiWord
>(process:24416): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 2 -> 1
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.Logger) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.Logger': no such name
>(process:24416): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.Logger: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/Logger.client
>(process:24416): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.Logger: im.telepathy.v1.Client.Observer
>(process:24416): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.Logger
>(process:24416): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 1 -> 0
>(process:24416): mcd-DEBUG: mcd_dispatcher_client_registry_ready_cb: All initial clients have been inspected
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.AbiWord:
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 channel filters
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 capability tokens:
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Foo
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Bar
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.Logger:
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 channel filters
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 capability tokens:
>(process:24416): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24416): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24416): mcd-DEBUG: get_usable_accounts: called
>(process:24416): mcd-DEBUG: get_unusable_accounts: called
>(process:24416): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24416): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ConnectionManager.fakecm,  -> :1.0)
>(process:24416): mcd-DEBUG: _mcd_account_manager_create_account: called
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x1962300: request 0x1988980 represents core features on TpProtocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties not supplied
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24416): tp-glib/proxy-DEBUG: request_is_complete: 0x1962300: calling callback for tp-protocol-feature-core
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962300: request 0x1988980 prepared
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x1988980
>(process:24416): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0x1962300: im.telepathy.v1.Protocol DBusGProxy is 0x19ab6c0
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: manager of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.manager
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.manager
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.manager
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: protocol of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.protocol
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.protocol
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.protocol
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: DisplayName of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mcd-DEBUG: _mcd_account_constructed: 0x19683d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: AutomaticPresence of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'fakeaccount'>, 'protocol': <'fakeprotocol'>, 'Parameters': <@a{sv} {}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x1962400: request 0x7f4b7c0018c0 represents core features on TpConnectionManager
>(process:24416): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_HOME: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/managers/fakecm.manager
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/managers/fakecm.manager
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24416): tp-glib/proxy-DEBUG: request_is_complete: 0x1962400: calling callback for tp-connection-manager-feature-core
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962400: core features not ready yet, nothing prepared
>(process:24416): mcd-DEBUG: mcd_manager_setup: Manager fakecm created
>(process:24416): mcd-DEBUG: _mcd_mission_set_parent: child = 0x1966e60, parent = 0x1960c20
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x1962300
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x1962300: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x1962300
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.ConnectionManager.fakecm) -> :1.0
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: is now running
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: starting introspection now we know the name owner
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm: calling GetAll on CM
>(process:24416): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0x1962400: org.freedesktop.DBus.Properties DBusGProxy is 0x19699a0
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: reading /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: fakecm: reading protocol 'fakeprotocol' from manager file
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: account
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x3
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: password
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0xb
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: nickname
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x2
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: register
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: com.example.Badgerable.Badgered
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x14
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: secret-mushroom
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: snakes
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 0 of type guint
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: contrived-example
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 5 of type guint
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x1962500: request 0x19c1820 represents core features on TpProtocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarHeight = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = NULL
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarHeight = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = ""
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0x1954500)
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = ""
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0x19c1800)
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = NULL
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarWidth = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarBytes = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = ""
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarHeight = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarWidth = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.SupportedAvatarMIMETypes = NULL
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = NULL
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarWidth = 0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24416): tp-glib/proxy-DEBUG: request_is_complete: 0x1962500: calling callback for tp-protocol-feature-core
>(process:24416): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962500: request 0x19c1820 prepared
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x19c1820
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: got info from file
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962400: request 0x7f4b7c0018c0 prepared
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x7f4b7c0018c0
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962400: request 0x1988700 prepared
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x1988700
>(process:24416): mcd-DEBUG: on_manager_ready: manager fakecm is ready
>(process:24416): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_account_check_parameters: missing required parameter 'account'
>(process:24416): mcd-DEBUG: _mcd_account_set_parameters: called
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_parameter: snakes of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-snakes
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-snakes
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store parameter fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-snakes
>(process:24416): mcd-DEBUG: mcd_storage_make_secret: flagging fakecm/fakeprotocol/dontdivert_40example_2ecom0 parameter password as secret
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_parameter: password of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store parameter fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_parameter: account of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-account
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-account
>(process:24416): mc-plugins-DEBUG: account-storage.c:562: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store parameter fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-account
>(process:24416): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: check_usability_check_parameters_cb: Account usability changed (old: 0, new: 1)
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: Usable
>(process:24416): mcd-DEBUG: mcd_account_changed_property: First changed property
>(process:24416): mcd-DEBUG: mcd_account_request_presence_int: Requested presence: 1 offline 
>(process:24416): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24416): mcd-DEBUG: add_account: adding account fakecm/fakeprotocol/dontdivert_40example_2ecom0 (0x19683d0) from complete_account_creation_set_cb
>(process:24416): mcd-DEBUG: add_account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0 usability: 1
>(process:24416): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_account_manager_write_conf_async: updating fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'fakeaccount'>, 'protocol': <'fakeprotocol'>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24416): mcd-DEBUG: proxy_new_cb: org.gnome.SessionManager service not found
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_get_all_cb: fakecm: 1 Protocols from GetAll()
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x1962600: request 0x19c1da0 represents core features on TpProtocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = []
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = "x-fakecm"
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = "im-fakecm"
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0x19c1d40)
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0x19c1b40)
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = []
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = "fakecm"
>(process:24416): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = []
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x8
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24416): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24416): tp-glib/proxy-DEBUG: request_is_complete: 0x1962600: calling callback for tp-protocol-feature-core
>(process:24416): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x1962600: request 0x19c1da0 prepared
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x19c1da0
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x1962500
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x1962500: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x1962500
>(process:24416): tp-glib/manager-DEBUG: tp_connection_manager_end_introspection: fakecm: end of introspection, info source live (2)
>(process:24416): mcd-DEBUG: emit_property_changed: called
>(process:24416): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24416): mcd-DEBUG: get_usable_accounts: called
>(process:24416): mcd-DEBUG: get_unusable_accounts: called
>(process:24416): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24416): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, DisplayName
>(process:24416): mcd-DEBUG: set_display_name: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: DisplayName of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.DisplayName
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'Work account'>, 'protocol': <'fakeprotocol'>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: DisplayName
>(process:24416): mcd-DEBUG: mcd_account_changed_property: First changed property
>(process:24416): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Icon
>(process:24416): mcd-DEBUG: set_icon: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: Icon of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.Icon
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.Icon
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.Icon
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'Icon': <'im-jabber'>, 'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'Work account'>, 'protocol': <'fakeprotocol'>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: Icon
>(process:24416): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Nickname
>(process:24416): mcd-DEBUG: set_nickname: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: Nickname of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.Nickname
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.Nickname
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.Nickname
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'Icon': <'im-jabber'>, 'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'Work account'>, 'protocol': <'fakeprotocol'>, 'Nickname': <'Joe Bloggs'>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: Nickname
>(process:24416): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, ConnectAutomatically
>(process:24416): mcd-DEBUG: set_connect_automatically: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_owns: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:421: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: ConnectAutomatically of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.ConnectAutomatically
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.ConnectAutomatically
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.ConnectAutomatically
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'Icon': <'im-jabber'>, 'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 0, '', '')>, 'DisplayName': <'Work account'>, 'protocol': <'fakeprotocol'>, 'Nickname': <'Joe Bloggs'>, 'ConnectAutomatically': <true>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: ConnectAutomatically
>(process:24416): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24416): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, AutomaticPresence
>(process:24416): mcd-DEBUG: set_automatic_presence: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: set_automatic_presence: setting automatic presence: 4, xa, never online
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: TestDBusAccount: 
>** (process:24416): DEBUG: test_dbus_account_plugin_set_attribute: AutomaticPresence of fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: TestDBusAccount: 
>(process:24416): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: diverted-keyfile: 
>(process:24416): mc-plugins-DEBUG: account-storage.c:475: diverted-keyfile: 
>(process:24416): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> ignore fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mc-plugins-DEBUG: account-storage.c:517: default: 
>(process:24416): mcd-DEBUG: update_storage: MCP:default -> store attribute fakecm/fakeprotocol/dontdivert_40example_2ecom0.AutomaticPresence
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24416): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24416): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24416): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24416): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24416): mcd-DEBUG: am_default_commit_one: {'Icon': <'im-jabber'>, 'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 4, 'xa', 'never online')>, 'DisplayName': <'Work account'>, 'protocol': <'fakeprotocol'>, 'Nickname': <'Joe Bloggs'>, 'ConnectAutomatically': <true>, 'Parameters': <{'snakes': <uint32 23>, 'password': <'secrecy'>, 'account': <'dontdivert@example.com'>}>, 'KeyFileParameters': <@a{ss} {}>}
>(process:24416): mcd-DEBUG: mcd_account_changed_property: called: AutomaticPresence
>** Message: Aborting by popular request
>(process:24416): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24416): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24416): mcd-DEBUG: on_parent_abort: called
>(process:24416): mcd-DEBUG: _mcd_mission_set_parent: child = 0x1966e60, parent = (nil)
>** (process:24416): DEBUG: McdService aborted, unreffing it
>(process:24416): mcd-DEBUG: Object Hierarchy of object 0x1960c20
>(process:24416): mcd-DEBUG: [
>(process:24416): mcd-DEBUG:     McdService (0x1960c20): 2
>(process:24416): mcd-DEBUG:         McdManager (0x1966e60): 2
>(process:24416): mcd-DEBUG: ]
>(process:24416): mcd-DEBUG: unref_account: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24416): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24416): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0x1960c20
>(process:24416): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0x1960c20
>(process:24416): mcd-DEBUG: emit_property_changed: called
>(process:24416): mcd-DEBUG: _mcd_account_dispose: 0x19683d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x19b18d0
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x19b18d0: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x19b18d0
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x19b19c0
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x19b19c0: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x19b19c0
>(process:24416): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x1962600
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x1962600: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x1962600
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x1962400
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x1962400: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x1962400
>(process:24416): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24416): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0x1966e60
>(process:24416): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0x1966e60
>(process:24416): mcd-DEBUG: mcd_inhibit_release: 0x197fa00 (fd -1): 1 -> 0
>(process:24416): mcd-DEBUG: _mcd_account_finalize: 0x19683d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x19649f0
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x19649f0: Proxy unreferenced
>(process:24416): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x19649f0
>** Message: Exiting with 0
>===== log file: missioncontrol-24448.log =====
>(process:24448): mcd-DEBUG: telepathy-mission-control version 5.99.6+
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.lai is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:160 mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:160 fake-network-monitor.o isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:160 dbus-account-plugin.o isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-account-diversion.so, ...) = 0x1669480
>** (process:24448): DEBUG: Initializing mcp-account-diversion-plugin (n=0)
>** (process:24448): DEBUG: account_diversion_plugin_class_init
>** (process:24448): DEBUG: account_diversion_plugin_init
>** (process:24448): DEBUG: Initializing mcp-account-diversion-plugin (n=1)
>(process:24448): mc-plugins-DEBUG: loader.c:202 1 plugin object(s) found in mcp-account-diversion.so
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-plugin.o is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.lai isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.la is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.so isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.la isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.o is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-plugin.la is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:160 lt-mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24448): mc-plugins-DEBUG: loader.c:166 mcp-plugin.lai is not a loadable module
>(process:24448): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-plugin.so, ...) = 0x1669ee0
>** (process:24448): DEBUG: Initializing mcp-plugin (n=0)
>** (process:24448): DEBUG: Initializing mcp-plugin (n=1)
>** (process:24448): DEBUG: Initializing mcp-plugin (n=2)
>** (process:24448): DEBUG: Initializing mcp-plugin (n=3)
>** (process:24448): DEBUG: Initializing mcp-plugin (n=4)
>** (process:24448): DEBUG: test_dbus_account_plugin_class_init: called
>** (process:24448): DEBUG: test_dbus_account_plugin_init: called
>** (process:24448): DEBUG: Initializing mcp-plugin (n=5)
>(process:24448): mc-plugins-DEBUG: loader.c:202 5 plugin object(s) found in mcp-plugin.so
>(process:24448): mcd-DEBUG: mcd_service_init: called
>(process:24448): mcd-DEBUG: _mcd_account_manager_constructed: 
>** (process:24448): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24448): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24448): DEBUG: fake_network_monitor_class_init: enter
>** (process:24448): DEBUG: fake_network_monitor_init: enter
>(process:24448): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are offline
>(process:24448): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 2 -> 0; stable: 4 -> 4; running: 8 -> 8
>(process:24448): mcd-DEBUG: connectivity_monitor_change_states: disconnected
>(process:24448): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24448): mcd-DEBUG: plugin_iface_init: 
>(process:24448): mcd-DEBUG: _mcd_account_manager_constructed: loading plugins
>(process:24448): mcd-DEBUG: mcd_account_manager_default_class_init: mcd_account_manager_default_class_init
>(process:24448): mcd-DEBUG: mcd_account_manager_default_init: mcd_account_manager_default_init
>(process:24448): mcd-DEBUG: sort_and_cache_plugins: found plugin TestDBusAccount [TestDBusAccountPlugin; priority 200]
>Regression test plugin
>(process:24448): mcd-DEBUG: sort_and_cache_plugins: found plugin diverted-keyfile [AccountDiversionPlugin; priority 100]
>Test plugin that grabs all accounts it receives (except 'fakecm/fakeprotocol/dontdivert*') and diverts them to 'mcp-test-diverted-account-plugin.conf' in g_get_user_cache_dir () instead of the usual location.
>(process:24448): mcd-DEBUG: sort_and_cache_plugins: found plugin default [McdAccountManagerDefault; priority 0]
>Default account storage backend
>(process:24448): mc-plugins-DEBUG: account-storage.c:823: default: 
>(process:24448): mcd-DEBUG: am_default_load_directory: Looking for accounts in /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24448): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0 from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24448): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control': No such file or directory
>(process:24448): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/mission-control': No such file or directory
>(process:24448): mcd-DEBUG: mcd_storage_load: listing from plugin default [prio: 0]
>(process:24448): mcd-DEBUG: mcd_storage_load: fetching fakecm/fakeprotocol/dontdivert_40example_2ecom0 from plugin default [prio: 0]
>(process:24448): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24448): mc-plugins-DEBUG: account-storage.c:823: diverted-keyfile: 
>** (process:24448): DEBUG: checking for /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/cache/mcp-test-diverted-account-plugin.conf
>(process:24448): mcd-DEBUG: mcd_storage_load: listing from plugin diverted-keyfile [prio: 100]
>(process:24448): mc-plugins-DEBUG: account-storage.c:823: TestDBusAccount: 
>** (process:24448): DEBUG: test_dbus_account_plugin_list: called
>(process:24448): mcd-DEBUG: mcd_storage_load: listing from plugin TestDBusAccount [prio: 200]
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal created 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal created 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal created 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal toggled 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal toggled 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal toggled 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal deleted 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal deleted 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal deleted 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal altered-one 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal altered-one 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal altered-one 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal reconnect 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal reconnect 
>(process:24448): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal reconnect 
>(process:24448): mcd-DEBUG: mcd_client_registry_constructed: Starting to look for clients
>(process:24448): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0x164d9f0: org.freedesktop.DBus DBusGProxy is 0x169d550
>(process:24448): mcd-DEBUG: _mcd_account_constructed: 0x16513d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x164b300: request 0x163d240 represents core features on TpConnectionManager
>(process:24448): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_HOME: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/managers/fakecm.manager
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/managers/fakecm.manager
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24448): tp-glib/proxy-DEBUG: request_is_complete: 0x164b300: calling callback for tp-connection-manager-feature-core
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x164b300: core features not ready yet, nothing prepared
>(process:24448): mcd-DEBUG: mcd_manager_setup: Manager fakecm created
>(process:24448): mcd-DEBUG: _mcd_mission_set_parent: child = 0x16731a0, parent = 0x1649c20
>(process:24448): mcd-DEBUG: add_account: adding account fakecm/fakeprotocol/dontdivert_40example_2ecom0 (0x16513d0) from keyfile
>(process:24448): mcd-DEBUG: add_account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0 usability: 0
>(process:24448): mcd-DEBUG: mcd_account_manager_write_conf_async: updating all 0 accounts
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:723: TestDBusAccount: committing all accounts
>** (process:24448): DEBUG: test_dbus_account_plugin_commit: called
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin default to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:723: default: committing all accounts
>(process:24448): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by TestDBusAccount
>** (process:24448): DEBUG: test_dbus_account_plugin_ready: called
>(process:24448): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by diverted-keyfile
>(process:24448): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by default
>(process:24448): mcd-DEBUG: release_load_accounts_lock: called, count is now 1
>(process:24448): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24448): mcd-DEBUG: mcd_service_constructed: called
>(process:24448): mcd-DEBUG: mcd_service_obtain_bus_name: Requesting MC dbus service
>(process:24448): mcd-DEBUG: Object Hierarchy of object 0x1649c20
>(process:24448): mcd-DEBUG: [
>(process:24448): mcd-DEBUG:     McdService (0x1649c20): 3
>(process:24448): mcd-DEBUG:         McdManager (0x16731a0): 2
>(process:24448): mcd-DEBUG: ]
>** (process:24448): DEBUG: fake_network_monitor_get_properties_cb: Initial state: online
>** (process:24448): DEBUG: fake_network_monitor_set_state: New fake ConnMan network state online (an available state)
>** (process:24448): DEBUG: fake_network_monitor_set_state: notify::network-available
>** (process:24448): DEBUG: fake_network_monitor_emit_network_changed: available=1
>(process:24448): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are at least partially online
>(process:24448): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 0 -> 2; stable: 4 -> 4; running: 8 -> 8
>(process:24448): mcd-DEBUG: connectivity_monitor_change_states: connected
>(process:24448): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24448): mcd-DEBUG: mcd_client_registry_list_names_cb: ListNames returned
>(process:24448): mcd-DEBUG: login1_inhibit_cb: unable to delay sleep and shutdown: g-dbus-error-quark #2: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.login1 was not provided by any .service files
>(process:24448): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ChannelDispatcher,  -> :1.5)
>(process:24448): mcd-DEBUG: list_connection_names_cb: 0 connections
>(process:24448): mcd-DEBUG: proxy_new_cb: org.gnome.SessionManager service not found
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.ConnectionManager.fakecm) -> :1.0
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: is now running
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: starting introspection now we know the name owner
>(process:24448): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.MissionControl6,  -> :1.5)
>(process:24448): mcd-DEBUG: mcd_client_registry_list_activatable_names_cb: ListActivatableNames returned
>(process:24448): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.AbiWord
>(process:24448): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.AbiWord
>(process:24448): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24448): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 1 -> 2
>(process:24448): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.Logger
>(process:24448): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.Logger
>(process:24448): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24448): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 2 -> 3
>(process:24448): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 3 -> 2
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.AbiWord) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.AbiWord': no such name
>(process:24448): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.AbiWord: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/AbiWord.client
>(process:24448): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.AbiWord: im.telepathy.v1.Client.Handler
>(process:24448): mcd-DEBUG: mcd_client_proxy_introspect: im.telepathy.v1.Client.AbiWord is a Handler but not active
>(process:24448): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.AbiWord
>(process:24448): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 2 -> 1
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.Logger) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.Logger': no such name
>(process:24448): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.Logger: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/Logger.client
>(process:24448): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.Logger: im.telepathy.v1.Client.Observer
>(process:24448): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.Logger
>(process:24448): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 1 -> 0
>(process:24448): mcd-DEBUG: mcd_dispatcher_client_registry_ready_cb: All initial clients have been inspected
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.AbiWord:
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 channel filters
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 capability tokens:
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Foo
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Bar
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.Logger:
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 channel filters
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 capability tokens:
>(process:24448): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm: calling GetAll on CM
>(process:24448): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0x164b300: org.freedesktop.DBus.Properties DBusGProxy is 0x1673930
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: reading /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: fakecm: reading protocol 'fakeprotocol' from manager file
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: account
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x3
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: password
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0xb
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: nickname
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x2
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: register
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: com.example.Badgerable.Badgered
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x14
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: secret-mushroom
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: snakes
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 0 of type guint
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: contrived-example
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 5 of type guint
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x164b400: request 0x16b18c0 represents core features on TpProtocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarHeight = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = NULL
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarHeight = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = ""
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0x16ac940)
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = ""
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0x16b18a0)
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = NULL
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarWidth = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarBytes = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = ""
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarHeight = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarWidth = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.SupportedAvatarMIMETypes = NULL
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = NULL
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarWidth = 0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24448): tp-glib/proxy-DEBUG: request_is_complete: 0x164b400: calling callback for tp-protocol-feature-core
>(process:24448): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x164b400: request 0x16b18c0 prepared
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x16b18c0
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: got info from file
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x164b300: request 0x163d240 prepared
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x163d240
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x164b300: request 0x1671b20 prepared
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x1671b20
>(process:24448): mcd-DEBUG: on_manager_ready: manager fakecm is ready
>(process:24448): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: release_load_accounts_lock: called, count is now 0
>(process:24448): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_get_all_cb: fakecm: 1 Protocols from GetAll()
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x164b500: request 0x16a7000 represents core features on TpProtocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = []
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = "x-fakecm"
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = "im-fakecm"
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0x16a8b80)
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0x16b1d00)
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = []
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = "fakecm"
>(process:24448): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = []
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x8
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24448): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24448): tp-glib/proxy-DEBUG: request_is_complete: 0x164b500: calling callback for tp-protocol-feature-core
>(process:24448): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x164b500: request 0x16a7000 prepared
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0x16a7000
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x164b400
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x164b400: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x164b400
>(process:24448): tp-glib/manager-DEBUG: tp_connection_manager_end_introspection: fakecm: end of introspection, info source live (2)
>(process:24448): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.AccountManager,  -> :1.5)
>(process:24448): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24448): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24448): mcd-DEBUG: get_usable_accounts: called
>(process:24448): mcd-DEBUG: get_unusable_accounts: called
>(process:24448): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24448): mcd-DEBUG: dbusprop_get: im.telepathy.v1.Account, Parameters
>(process:24448): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Parameters
>(process:24448): mcd-DEBUG: _mcd_account_dup_parameters: called
>(process:24448): mcd-DEBUG: account_remove: called
>** (process:24448): DEBUG: test_dbus_account_plugin_owns: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mc-plugins-DEBUG: account-storage.c:421: diverted-keyfile: 
>(process:24448): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: TestDBusAccount: 
>** (process:24448): DEBUG: test_dbus_account_plugin_delete: called
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: diverted-keyfile: 
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: default: 
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24448): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24448): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24448): mcd-DEBUG: am_default_commit_one: Deleting account fakecm/fakeprotocol/dontdivert_40example_2ecom0 from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24448): mcd-DEBUG: unref_account: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: TestDBusAccount: 
>** (process:24448): DEBUG: test_dbus_account_plugin_delete: called
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: diverted-keyfile: 
>(process:24448): mc-plugins-DEBUG: account-storage.c:680: default: 
>(process:24448): mcd-DEBUG: mcd_account_manager_write_conf_async: updating fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24448): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24448): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24448): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24448): mcd-DEBUG: _mcd_account_dispose: 0x16513d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24448): mcd-DEBUG: _mcd_account_finalize: 0x16513d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>** Message: Aborting by popular request
>(process:24448): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24448): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24448): mcd-DEBUG: on_parent_abort: called
>(process:24448): mcd-DEBUG: _mcd_mission_set_parent: child = 0x16731a0, parent = (nil)
>** (process:24448): DEBUG: McdService aborted, unreffing it
>(process:24448): mcd-DEBUG: Object Hierarchy of object 0x1649c20
>(process:24448): mcd-DEBUG: [
>(process:24448): mcd-DEBUG:     McdService (0x1649c20): 2
>(process:24448): mcd-DEBUG:         McdManager (0x16731a0): 1
>(process:24448): mcd-DEBUG: ]
>(process:24448): mcd-DEBUG: mcd_inhibit_release: 0x165c520 (fd -1): 1 -> 0
>(process:24448): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x16ac0c0
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x16ac0c0: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x16ac0c0
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x16ac1b0
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x16ac1b0: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x16ac1b0
>(process:24448): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x164b500
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x164b500: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x164b500
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x164b300
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x164b300: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x164b300
>(process:24448): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24448): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0x16731a0
>(process:24448): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0x16731a0
>(process:24448): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0x1649c20
>(process:24448): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0x1649c20
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x164d9f0
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x164d9f0: Proxy unreferenced
>(process:24448): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x164d9f0
>** Message: Exiting with 0
>===== log file: missioncontrol-24469.log =====
>(process:24469): mcd-DEBUG: telepathy-mission-control version 5.99.6+
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.lai is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:160 mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:160 fake-network-monitor.o isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:160 dbus-account-plugin.o isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-account-diversion.so, ...) = 0xd77450
>** (process:24469): DEBUG: Initializing mcp-account-diversion-plugin (n=0)
>** (process:24469): DEBUG: account_diversion_plugin_class_init
>** (process:24469): DEBUG: account_diversion_plugin_init
>** (process:24469): DEBUG: Initializing mcp-account-diversion-plugin (n=1)
>(process:24469): mc-plugins-DEBUG: loader.c:202 1 plugin object(s) found in mcp-account-diversion.so
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-plugin.o is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.lai isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.la is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.so isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.la isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.o is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-plugin.la is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:160 lt-mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24469): mc-plugins-DEBUG: loader.c:166 mcp-plugin.lai is not a loadable module
>(process:24469): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-plugin.so, ...) = 0xd77eb0
>** (process:24469): DEBUG: Initializing mcp-plugin (n=0)
>** (process:24469): DEBUG: Initializing mcp-plugin (n=1)
>** (process:24469): DEBUG: Initializing mcp-plugin (n=2)
>** (process:24469): DEBUG: Initializing mcp-plugin (n=3)
>** (process:24469): DEBUG: Initializing mcp-plugin (n=4)
>** (process:24469): DEBUG: test_dbus_account_plugin_class_init: called
>** (process:24469): DEBUG: test_dbus_account_plugin_init: called
>** (process:24469): DEBUG: Initializing mcp-plugin (n=5)
>(process:24469): mc-plugins-DEBUG: loader.c:202 5 plugin object(s) found in mcp-plugin.so
>(process:24469): mcd-DEBUG: mcd_service_init: called
>(process:24469): mcd-DEBUG: _mcd_account_manager_constructed: 
>** (process:24469): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24469): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24469): DEBUG: fake_network_monitor_class_init: enter
>** (process:24469): DEBUG: fake_network_monitor_init: enter
>(process:24469): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are offline
>(process:24469): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 2 -> 0; stable: 4 -> 4; running: 8 -> 8
>(process:24469): mcd-DEBUG: connectivity_monitor_change_states: disconnected
>(process:24469): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24469): mcd-DEBUG: plugin_iface_init: 
>(process:24469): mcd-DEBUG: _mcd_account_manager_constructed: loading plugins
>(process:24469): mcd-DEBUG: mcd_account_manager_default_class_init: mcd_account_manager_default_class_init
>(process:24469): mcd-DEBUG: mcd_account_manager_default_init: mcd_account_manager_default_init
>(process:24469): mcd-DEBUG: sort_and_cache_plugins: found plugin TestDBusAccount [TestDBusAccountPlugin; priority 200]
>Regression test plugin
>(process:24469): mcd-DEBUG: sort_and_cache_plugins: found plugin diverted-keyfile [AccountDiversionPlugin; priority 100]
>Test plugin that grabs all accounts it receives (except 'fakecm/fakeprotocol/dontdivert*') and diverts them to 'mcp-test-diverted-account-plugin.conf' in g_get_user_cache_dir () instead of the usual location.
>(process:24469): mcd-DEBUG: sort_and_cache_plugins: found plugin default [McdAccountManagerDefault; priority 0]
>Default account storage backend
>(process:24469): mc-plugins-DEBUG: account-storage.c:823: default: 
>(process:24469): mcd-DEBUG: am_default_load_directory: Looking for accounts in /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0priority.account
>(process:24469): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0masked from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0masked.account
>(process:24469): mcd-DEBUG: am_default_load_variant_file: Empty file /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0masked.account masks account fakecm/fakeprotocol/dontdivert_40example_2ecom0masked
>(process:24469): mcd-DEBUG: am_default_load_directory: Looking for accounts in /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0priority.account
>(process:24469): mcd-DEBUG: am_default_load_variant_file: Ignoring /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0priority.account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0priority already loaded
>(process:24469): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0 from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24469): mcd-DEBUG: am_default_load_variant_file: fakecm/fakeprotocol/dontdivert_40example_2ecom0masked from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0masked.account
>(process:24469): mcd-DEBUG: am_default_load_variant_file: Ignoring /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0masked.account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0masked already masked
>(process:24469): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/mission-control': No such file or directory
>(process:24469): mcd-DEBUG: mcd_storage_load: listing from plugin default [prio: 0]
>(process:24469): mcd-DEBUG: mcd_storage_load: fetching fakecm/fakeprotocol/dontdivert_40example_2ecom0masked from plugin default [prio: 0]
>(process:24469): mc-plugins-DEBUG: account-storage.c:421: default: 
>
>(process:24469): mcd-WARNING **: plugin default disowned account fakecm/fakeprotocol/dontdivert_40example_2ecom0masked
>(process:24469): mcd-DEBUG: mcd_storage_load: fetching fakecm/fakeprotocol/dontdivert_40example_2ecom0priority from plugin default [prio: 0]
>(process:24469): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24469): mcd-DEBUG: mcd_storage_load: fetching fakecm/fakeprotocol/dontdivert_40example_2ecom0 from plugin default [prio: 0]
>(process:24469): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24469): mc-plugins-DEBUG: account-storage.c:823: diverted-keyfile: 
>** (process:24469): DEBUG: checking for /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/cache/mcp-test-diverted-account-plugin.conf
>(process:24469): mcd-DEBUG: mcd_storage_load: listing from plugin diverted-keyfile [prio: 100]
>(process:24469): mc-plugins-DEBUG: account-storage.c:823: TestDBusAccount: 
>** (process:24469): DEBUG: test_dbus_account_plugin_list: called
>(process:24469): mcd-DEBUG: mcd_storage_load: listing from plugin TestDBusAccount [prio: 200]
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal created 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal created 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal created 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal toggled 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal toggled 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal toggled 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal deleted 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal deleted 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal deleted 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal altered-one 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal altered-one 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal altered-one 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal reconnect 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal reconnect 
>(process:24469): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal reconnect 
>(process:24469): mcd-DEBUG: mcd_client_registry_constructed: Starting to look for clients
>(process:24469): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0xd5b9f0: org.freedesktop.DBus DBusGProxy is 0xdb3d40
>(process:24469): mcd-DEBUG: _mcd_account_constructed: 0xd5f3d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0xd59300: request 0xd7fac0 represents core features on TpConnectionManager
>(process:24469): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_HOME: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/managers/fakecm.manager
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/managers/fakecm.manager
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_find_manager_file: in XDG_DATA_DIRS: trying /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24469): tp-glib/proxy-DEBUG: request_is_complete: 0xd59300: calling callback for tp-connection-manager-feature-core
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0xd59300: core features not ready yet, nothing prepared
>(process:24469): mcd-DEBUG: mcd_manager_setup: Manager fakecm created
>(process:24469): mcd-DEBUG: _mcd_mission_set_parent: child = 0xd810e0, parent = 0xd57c20
>(process:24469): mcd-DEBUG: add_account: adding account fakecm/fakeprotocol/dontdivert_40example_2ecom0 (0xd5f3d0) from keyfile
>(process:24469): mcd-DEBUG: add_account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0 usability: 0
>(process:24469): mcd-DEBUG: _mcd_account_constructed: 0xd5f520 (fakecm/fakeprotocol/dontdivert_40example_2ecom0priority)
>(process:24469): mcd-DEBUG: add_account: adding account fakecm/fakeprotocol/dontdivert_40example_2ecom0priority (0xd5f520) from keyfile
>(process:24469): mcd-DEBUG: add_account: account fakecm/fakeprotocol/dontdivert_40example_2ecom0priority usability: 0
>(process:24469): mcd-DEBUG: mcd_account_manager_write_conf_async: updating all 0 accounts
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: TestDBusAccount: committing all accounts
>** (process:24469): DEBUG: test_dbus_account_plugin_commit: called
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin default to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: default: committing all accounts
>(process:24469): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by TestDBusAccount
>** (process:24469): DEBUG: test_dbus_account_plugin_ready: called
>(process:24469): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by diverted-keyfile
>(process:24469): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by default
>(process:24469): mcd-DEBUG: release_load_accounts_lock: called, count is now 2
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority not Enabled
>(process:24469): mcd-DEBUG: mcd_service_constructed: called
>(process:24469): mcd-DEBUG: mcd_service_obtain_bus_name: Requesting MC dbus service
>(process:24469): mcd-DEBUG: Object Hierarchy of object 0xd57c20
>(process:24469): mcd-DEBUG: [
>(process:24469): mcd-DEBUG:     McdService (0xd57c20): 3
>(process:24469): mcd-DEBUG:         McdManager (0xd810e0): 3
>(process:24469): mcd-DEBUG: ]
>** (process:24469): DEBUG: fake_network_monitor_get_properties_cb: Initial state: online
>** (process:24469): DEBUG: fake_network_monitor_set_state: New fake ConnMan network state online (an available state)
>** (process:24469): DEBUG: fake_network_monitor_set_state: notify::network-available
>** (process:24469): DEBUG: fake_network_monitor_emit_network_changed: available=1
>(process:24469): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are at least partially online
>(process:24469): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 0 -> 2; stable: 4 -> 4; running: 8 -> 8
>(process:24469): mcd-DEBUG: connectivity_monitor_change_states: connected
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority not Enabled
>(process:24469): mcd-DEBUG: mcd_client_registry_list_names_cb: ListNames returned
>(process:24469): mcd-DEBUG: login1_inhibit_cb: unable to delay sleep and shutdown: g-dbus-error-quark #2: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.login1 was not provided by any .service files
>(process:24469): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ChannelDispatcher,  -> :1.8)
>(process:24469): mcd-DEBUG: list_connection_names_cb: 0 connections
>(process:24469): mcd-DEBUG: proxy_new_cb: org.gnome.SessionManager service not found
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.ConnectionManager.fakecm) -> :1.0
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: is now running
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_name_owner_changed_cb: fakecm: starting introspection now we know the name owner
>(process:24469): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.MissionControl6,  -> :1.8)
>(process:24469): mcd-DEBUG: mcd_client_registry_list_activatable_names_cb: ListActivatableNames returned
>(process:24469): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.AbiWord
>(process:24469): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.AbiWord
>(process:24469): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24469): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 1 -> 2
>(process:24469): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.Logger
>(process:24469): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.Logger
>(process:24469): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24469): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 2 -> 3
>(process:24469): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 3 -> 2
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.AbiWord) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.AbiWord': no such name
>(process:24469): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.AbiWord: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/AbiWord.client
>(process:24469): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.AbiWord: im.telepathy.v1.Client.Handler
>(process:24469): mcd-DEBUG: mcd_client_proxy_introspect: im.telepathy.v1.Client.AbiWord is a Handler but not active
>(process:24469): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.AbiWord
>(process:24469): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 2 -> 1
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.Logger) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.Logger': no such name
>(process:24469): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.Logger: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/Logger.client
>(process:24469): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.Logger: im.telepathy.v1.Client.Observer
>(process:24469): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.Logger
>(process:24469): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 1 -> 0
>(process:24469): mcd-DEBUG: mcd_dispatcher_client_registry_ready_cb: All initial clients have been inspected
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.AbiWord:
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 channel filters
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 capability tokens:
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Foo
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Bar
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.Logger:
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 channel filters
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 capability tokens:
>(process:24469): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm: calling GetAll on CM
>(process:24469): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0xd59300: org.freedesktop.DBus.Properties DBusGProxy is 0xd81a20
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: reading /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/managers/fakecm.manager
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: fakecm: reading protocol 'fakeprotocol' from manager file
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: account
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x3
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: password
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0xb
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: nickname
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x2
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: register
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: com.example.Badgerable.Badgered
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x14
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: secret-mushroom
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: snakes
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x0
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 0 of type guint
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param name: contrived-example
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: _tp_protocol_parse_manager_file: 	Param default value: 5 of type guint
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0xd59400: request 0xdc8000 represents core features on TpProtocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarHeight = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = NULL
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarHeight = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = ""
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0xdc7e80)
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = ""
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0xdc7fa0)
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = NULL
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.RecommendedAvatarWidth = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarBytes = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = ""
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarHeight = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MinimumAvatarWidth = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.SupportedAvatarMIMETypes = NULL
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = NULL
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interface.Avatars1.MaximumAvatarWidth = 0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: NULL of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24469): tp-glib/proxy-DEBUG: request_is_complete: 0xd59400: calling callback for tp-protocol-feature-core
>(process:24469): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0xd59400: request 0xdc8000 prepared
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0xdc8000
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_idle_read_manager_file: fakecm: got info from file
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0xd59300: request 0xd7fac0 prepared
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0xd7fac0
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0xd59300: request 0xd7f720 prepared
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0xd7f720
>(process:24469): mcd-DEBUG: on_manager_ready: manager fakecm is ready
>(process:24469): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: release_load_accounts_lock: called, count is now 1
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority not Enabled
>(process:24469): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: release_load_accounts_lock: called, count is now 0
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_get_all_cb: fakecm: 1 Protocols from GetAll()
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0xd59500: request 0xdbd880 represents core features on TpProtocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: fakecm/fakeprotocol: new Protocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: immutable properties already supplied
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.ConnectionInterfaces = []
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.VCardField = "x-fakecm"
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Icon = "im-fakecm"
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Parameters = ((GPtrArray_GValueArray_gchararray+guint+gchararray+GValue__*) 0xdc80a0)
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.RequestableChannelClasses = ((GPtrArray_GValueArray_GHashTable_gchararray+GValue_+GStrv__*) 0xdbef20)
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.Interfaces = []
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.EnglishName = "fakecm"
>(process:24469): tp-glib/params-DEBUG: tp_protocol_constructed: im.telepathy.v1.Protocol.AuthenticationTypes = []
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: Protocol name: fakeprotocol
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: account
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x3
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: password
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0xb
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: nickname
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x2
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: register
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: com.example.Badgerable.Badgered
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x14
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: b
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: FALSE of type gboolean
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: secret-mushroom
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x8
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: s
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: "" of type gchararray
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: snakes
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x0
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 0 of type guint
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param name: contrived-example
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param flags: 0x4
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param sig: u
>(process:24469): tp-glib/params-DEBUG: tp_protocol_params_from_param_specs: 	Param default value: 5 of type guint
>(process:24469): tp-glib/proxy-DEBUG: request_is_complete: 0xd59500: calling callback for tp-protocol-feature-core
>(process:24469): tp-glib/params-DEBUG: tp_protocol_check_for_core: Core feature ready
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0xd59500: request 0xdbd880 prepared
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_prepare_request_finish: 0xdbd880
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_continue_introspection: fakecm
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xd59400
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xd59400: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xd59400
>(process:24469): tp-glib/manager-DEBUG: tp_connection_manager_end_introspection: fakecm: end of introspection, info source live (2)
>(process:24469): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.AccountManager,  -> :1.8)
>(process:24469): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24469): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24469): mcd-DEBUG: get_usable_accounts: called
>(process:24469): mcd-DEBUG: get_unusable_accounts: called
>(process:24469): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24469): mcd-DEBUG: dbusprop_get: im.telepathy.v1.Account, Parameters
>(process:24469): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Parameters
>(process:24469): mcd-DEBUG: _mcd_account_dup_parameters: called
>(process:24469): mcd-DEBUG: dbusprop_get: im.telepathy.v1.Account, Parameters
>(process:24469): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Parameters
>(process:24469): mcd-DEBUG: _mcd_account_dup_parameters: called
>(process:24469): mcd-DEBUG: account_update_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: _mcd_account_set_parameters: called
>(process:24469): mcd-DEBUG: mcd_storage_make_secret: flagging fakecm/fakeprotocol/dontdivert_40example_2ecom0 parameter password as secret
>(process:24469): mcd-DEBUG: update_storage: MCP:TestDBusAccount -> delete fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: TestDBusAccount: 
>** (process:24469): DEBUG: test_dbus_account_plugin_delete: called
>(process:24469): mcd-DEBUG: update_storage: MCP:diverted-keyfile -> delete fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: diverted-keyfile: 
>(process:24469): mcd-DEBUG: update_storage: MCP:default -> delete fakecm/fakeprotocol/dontdivert_40example_2ecom0.param-password
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: default: 
>(process:24469): mcd-DEBUG: mcd_account_check_parameters: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: mcd_account_check_parameters: missing required parameter 'password'
>(process:24469): mcd-DEBUG: check_usability_check_parameters_cb: Account usability changed (old: 1, new: 0)
>(process:24469): mcd-DEBUG: mcd_account_changed_property: called: Usable
>(process:24469): mcd-DEBUG: mcd_account_changed_property: First changed property
>(process:24469): mcd-DEBUG: mcd_account_would_like_to_connect: fakecm/fakeprotocol/dontdivert_40example_2ecom0 not Enabled
>(process:24469): mcd-DEBUG: _mcd_account_dup_parameters: called
>(process:24469): mcd-DEBUG: mcd_account_changed_property: called: Parameters
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>** (process:24469): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0 to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: am_default_commit_one: Saving account fakecm/fakeprotocol/dontdivert_40example_2ecom0 to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0.account
>(process:24469): mcd-DEBUG: am_default_commit_one: {'manager': <'fakecm'>, 'AutomaticPresence': <(uint32 2, 'available', '')>, 'DisplayName': <'New and improved account'>, 'protocol': <'fakeprotocol'>, 'Parameters': <@a{sv} {}>, 'KeyFileParameters': <{'snakes': '42', 'account': 'dontdivert@example.com'}>}
>(process:24469): mcd-DEBUG: emit_property_changed: called
>(process:24469): mcd-DEBUG: dbusprop_get: im.telepathy.v1.Account, Nickname
>(process:24469): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, Nickname
>(process:24469): mcd-DEBUG: dbusprop_get: im.telepathy.v1.Account, DisplayName
>(process:24469): mcd-DEBUG: get_mcddbusprop: im.telepathy.v1.Account, DisplayName
>(process:24469): mcd-DEBUG: account_remove: called
>** (process:24469): DEBUG: test_dbus_account_plugin_owns: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mc-plugins-DEBUG: account-storage.c:421: diverted-keyfile: 
>(process:24469): mc-plugins-DEBUG: account-storage.c:421: default: 
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: TestDBusAccount: 
>** (process:24469): DEBUG: test_dbus_account_plugin_delete: called
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: diverted-keyfile: 
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: default: 
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>** (process:24469): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24469): mcd-DEBUG: am_default_commit_one: Deleting account fakecm/fakeprotocol/dontdivert_40example_2ecom0priority from /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control/fakecm-fakeprotocol-dontdivert_40example_2ecom0priority.account
>(process:24469): mcd-DEBUG: unref_account: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: TestDBusAccount: 
>** (process:24469): DEBUG: test_dbus_account_plugin_delete: called
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: diverted-keyfile: 
>(process:24469): mc-plugins-DEBUG: account-storage.c:680: default: 
>(process:24469): mcd-DEBUG: mcd_account_manager_write_conf_async: updating fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: TestDBusAccount: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>** (process:24469): DEBUG: test_dbus_account_plugin_commit_one: fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: diverted-keyfile: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24469): mcd-DEBUG: mcd_storage_commit: flushing plugin default fakecm/fakeprotocol/dontdivert_40example_2ecom0priority to long term storage
>(process:24469): mc-plugins-DEBUG: account-storage.c:781: default: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0priority
>(process:24469): mcd-DEBUG: _mcd_account_dispose: 0xd5f520 (fakecm/fakeprotocol/dontdivert_40example_2ecom0priority)
>(process:24469): mcd-DEBUG: _mcd_account_finalize: 0xd5f520 (fakecm/fakeprotocol/dontdivert_40example_2ecom0priority)
>** Message: Aborting by popular request
>(process:24469): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24469): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>(process:24469): mcd-DEBUG: on_parent_abort: called
>(process:24469): mcd-DEBUG: _mcd_mission_set_parent: child = 0xd810e0, parent = (nil)
>** (process:24469): DEBUG: McdService aborted, unreffing it
>(process:24469): mcd-DEBUG: Object Hierarchy of object 0xd57c20
>(process:24469): mcd-DEBUG: [
>(process:24469): mcd-DEBUG:     McdService (0xd57c20): 2
>(process:24469): mcd-DEBUG:         McdManager (0xd810e0): 2
>(process:24469): mcd-DEBUG: ]
>(process:24469): mcd-DEBUG: unref_account: called for fakecm/fakeprotocol/dontdivert_40example_2ecom0
>(process:24469): mcd-DEBUG: _mcd_account_dispose: 0xd5f3d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24469): mcd-DEBUG: mcd_inhibit_release: 0xd53c10 (fd -1): 1 -> 0
>(process:24469): mcd-DEBUG: _mcd_account_finalize: 0xd5f3d0 (fakecm/fakeprotocol/dontdivert_40example_2ecom0)
>(process:24469): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xdc28c0
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xdc28c0: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xdc28c0
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xdc29b0
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xdc29b0: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xdc29b0
>(process:24469): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.ConnectionManager.fakecm'
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xd59500
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xd59500: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xd59500
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xd59300
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xd59300: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xd59300
>(process:24469): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24469): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0xd810e0
>(process:24469): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0xd810e0
>(process:24469): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0xd57c20
>(process:24469): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0xd57c20
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xd5b9f0
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xd5b9f0: Proxy unreferenced
>(process:24469): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xd5b9f0
>** Message: Exiting with 0
>===== log file: missioncontrol-24491.log =====
>(process:24491): mcd-DEBUG: telepathy-mission-control version 5.99.6+
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.lai is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:160 mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:160 fake-network-monitor.o isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:160 dbus-account-plugin.o isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-account-diversion.so, ...) = 0xc71450
>** (process:24491): DEBUG: Initializing mcp-account-diversion-plugin (n=0)
>** (process:24491): DEBUG: account_diversion_plugin_class_init
>** (process:24491): DEBUG: account_diversion_plugin_init
>** (process:24491): DEBUG: Initializing mcp-account-diversion-plugin (n=1)
>(process:24491): mc-plugins-DEBUG: loader.c:202 1 plugin object(s) found in mcp-account-diversion.so
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-plugin.o is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.lai isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.la is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.so isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:160 libgiofakenetworkmonitor.la isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-account-diversion.o is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-plugin.la is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:160 lt-mc-debug-server isn't a plugin (doesn't start with mcp-)
>(process:24491): mc-plugins-DEBUG: loader.c:166 mcp-plugin.lai is not a loadable module
>(process:24491): mc-plugins-DEBUG: loader.c:174 g_module_open (/home/cassidy/dev/telepathy-mission-control/tests/twisted/.libs/mcp-plugin.so, ...) = 0xc71eb0
>** (process:24491): DEBUG: Initializing mcp-plugin (n=0)
>** (process:24491): DEBUG: Initializing mcp-plugin (n=1)
>** (process:24491): DEBUG: Initializing mcp-plugin (n=2)
>** (process:24491): DEBUG: Initializing mcp-plugin (n=3)
>** (process:24491): DEBUG: Initializing mcp-plugin (n=4)
>** (process:24491): DEBUG: test_dbus_account_plugin_class_init: called
>** (process:24491): DEBUG: test_dbus_account_plugin_init: called
>** (process:24491): DEBUG: Initializing mcp-plugin (n=5)
>(process:24491): mc-plugins-DEBUG: loader.c:202 5 plugin object(s) found in mcp-plugin.so
>(process:24491): mcd-DEBUG: mcd_service_init: called
>(process:24491): mcd-DEBUG: _mcd_account_manager_constructed: 
>** (process:24491): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24491): DEBUG: g_io_module_load: FakeNetworkMonitor plugin
>** (process:24491): DEBUG: fake_network_monitor_class_init: enter
>** (process:24491): DEBUG: fake_network_monitor_init: enter
>(process:24491): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are offline
>(process:24491): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 2 -> 0; stable: 4 -> 4; running: 8 -> 8
>(process:24491): mcd-DEBUG: connectivity_monitor_change_states: disconnected
>(process:24491): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24491): mcd-DEBUG: plugin_iface_init: 
>(process:24491): mcd-DEBUG: _mcd_account_manager_constructed: loading plugins
>(process:24491): mcd-DEBUG: mcd_account_manager_default_class_init: mcd_account_manager_default_class_init
>(process:24491): mcd-DEBUG: mcd_account_manager_default_init: mcd_account_manager_default_init
>(process:24491): mcd-DEBUG: sort_and_cache_plugins: found plugin TestDBusAccount [TestDBusAccountPlugin; priority 200]
>Regression test plugin
>(process:24491): mcd-DEBUG: sort_and_cache_plugins: found plugin diverted-keyfile [AccountDiversionPlugin; priority 100]
>Test plugin that grabs all accounts it receives (except 'fakecm/fakeprotocol/dontdivert*') and diverts them to 'mcp-test-diverted-account-plugin.conf' in g_get_user_cache_dir () instead of the usual location.
>(process:24491): mcd-DEBUG: sort_and_cache_plugins: found plugin default [McdAccountManagerDefault; priority 0]
>Default account storage backend
>(process:24491): mc-plugins-DEBUG: account-storage.c:823: default: 
>(process:24491): mcd-DEBUG: am_default_load_directory: Looking for accounts in /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24491): mcd-DEBUG: am_default_load_directory: Looking for accounts in /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/share/telepathy-1/mission-control
>(process:24491): mcd-DEBUG: am_default_load_directory: Error opening directory '/home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/mission-control': No such file or directory
>(process:24491): mcd-DEBUG: _list: Creating initial account data
>(process:24491): mcd-DEBUG: _list: Saving initial or migrated account data
>(process:24491): mcd-DEBUG: _commit: Saving accounts to /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24491): mcd-DEBUG: mcd_ensure_directory: /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/localshare/telepathy-1/mission-control
>(process:24491): mcd-DEBUG: mcd_storage_load: listing from plugin default [prio: 0]
>(process:24491): mc-plugins-DEBUG: account-storage.c:823: diverted-keyfile: 
>** (process:24491): DEBUG: checking for /home/cassidy/dev/telepathy-mission-control/tests/twisted/tmp-account-storage_default-keyring-storage_py/cache/mcp-test-diverted-account-plugin.conf
>(process:24491): mcd-DEBUG: mcd_storage_load: listing from plugin diverted-keyfile [prio: 100]
>(process:24491): mc-plugins-DEBUG: account-storage.c:823: TestDBusAccount: 
>** (process:24491): DEBUG: test_dbus_account_plugin_list: called
>(process:24491): mcd-DEBUG: mcd_storage_load: listing from plugin TestDBusAccount [prio: 200]
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal created 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal created 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal created 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal toggled 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal toggled 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal toggled 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal deleted 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal deleted 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal deleted 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal altered-one 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal altered-one 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal altered-one 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to TestDBusAccount plugin signal reconnect 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to diverted-keyfile plugin signal reconnect 
>(process:24491): mcd-DEBUG: mcd_storage_connect_signal: connecting handler to default plugin signal reconnect 
>(process:24491): mcd-DEBUG: mcd_client_registry_constructed: Starting to look for clients
>(process:24491): tp-glib/proxy-DEBUG: _tp_proxy_get_interface_by_id: 0xc559f0: org.freedesktop.DBus DBusGProxy is 0xcac970
>(process:24491): mcd-DEBUG: mcd_account_manager_write_conf_async: updating all 0 accounts
>(process:24491): mcd-DEBUG: mcd_storage_commit: flushing plugin TestDBusAccount to long term storage
>(process:24491): mc-plugins-DEBUG: account-storage.c:723: TestDBusAccount: committing all accounts
>** (process:24491): DEBUG: test_dbus_account_plugin_commit: called
>(process:24491): mcd-DEBUG: mcd_storage_commit: flushing plugin diverted-keyfile to long term storage
>(process:24491): mc-plugins-DEBUG: account-storage.c:723: diverted-keyfile: committing all accounts
>(process:24491): mcd-DEBUG: mcd_storage_commit: flushing plugin default to long term storage
>(process:24491): mc-plugins-DEBUG: account-storage.c:723: default: committing all accounts
>(process:24491): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by TestDBusAccount
>** (process:24491): DEBUG: test_dbus_account_plugin_ready: called
>(process:24491): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by diverted-keyfile
>(process:24491): mcd-DEBUG: mcd_storage_ready: Unblocking async account ops by default
>(process:24491): mcd-DEBUG: release_load_accounts_lock: called, count is now 0
>(process:24491): mcd-DEBUG: mcd_service_constructed: called
>(process:24491): mcd-DEBUG: mcd_service_obtain_bus_name: Requesting MC dbus service
>(process:24491): mcd-DEBUG: Object Hierarchy of object 0xc51c20
>(process:24491): mcd-DEBUG: [
>(process:24491): mcd-DEBUG:     McdService (0xc51c20): 2
>(process:24491): mcd-DEBUG: ]
>** (process:24491): DEBUG: fake_network_monitor_get_properties_cb: Initial state: online
>** (process:24491): DEBUG: fake_network_monitor_set_state: New fake ConnMan network state online (an available state)
>** (process:24491): DEBUG: fake_network_monitor_set_state: notify::network-available
>** (process:24491): DEBUG: fake_network_monitor_emit_network_changed: available=1
>(process:24491): mcd-DEBUG: connectivity_monitor_network_changed: GNetworkMonitor (FakeNetworkMonitor) says we are at least partially online
>(process:24491): mcd-DEBUG: connectivity_monitor_change_states: awake: 1 -> 1; up: 0 -> 2; stable: 4 -> 4; running: 8 -> 8
>(process:24491): mcd-DEBUG: connectivity_monitor_change_states: connected
>(process:24491): mcd-DEBUG: mcd_client_registry_list_names_cb: ListNames returned
>(process:24491): mcd-DEBUG: login1_inhibit_cb: unable to delay sleep and shutdown: g-dbus-error-quark #2: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.login1 was not provided by any .service files
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ChannelDispatcher,  -> :1.11)
>(process:24491): mcd-DEBUG: list_connection_names_cb: 0 connections
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.AccountManager,  -> :1.11)
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.MissionControl6,  -> :1.11)
>(process:24491): mcd-DEBUG: mcd_client_registry_list_activatable_names_cb: ListActivatableNames returned
>(process:24491): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.AbiWord
>(process:24491): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.AbiWord
>(process:24491): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24491): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 1 -> 2
>(process:24491): mcd-DEBUG: _mcd_client_registry_found_name: Registering client im.telepathy.v1.Client.Logger
>(process:24491): mcd-DEBUG: mcd_client_proxy_constructed: im.telepathy.v1.Client.Logger
>(process:24491): tp-glib/proxy-DEBUG: tp_dbus_daemon_watch_name_owner: Adding match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24491): mcd-DEBUG: _mcd_client_registry_inc_startup_lock: 2 -> 3
>(process:24491): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 3 -> 2
>(process:24491): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.AbiWord) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.AbiWord': no such name
>(process:24491): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.AbiWord: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/AbiWord.client
>(process:24491): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.AbiWord: im.telepathy.v1.Client.Handler
>(process:24491): mcd-DEBUG: mcd_client_proxy_introspect: im.telepathy.v1.Client.AbiWord is a Handler but not active
>(process:24491): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.AbiWord
>(process:24491): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 2 -> 1
>(process:24491): tp-glib/proxy-DEBUG: _tp_dbus_daemon_get_name_owner_idle: GetNameOwner(im.telepathy.v1.Client.Logger) raised org.freedesktop.DBus.Error.NameHasNoOwner: Could not get owner of name 'im.telepathy.v1.Client.Logger': no such name
>(process:24491): mcd-DEBUG: _mcd_client_proxy_parse_client_file: File found for im.telepathy.v1.Client.Logger: /home/cassidy/dev/telepathy-mission-control/tests/twisted/telepathy-1/clients/Logger.client
>(process:24491): mcd-DEBUG: _mcd_client_proxy_add_interfaces: im.telepathy.v1.Client.Logger: im.telepathy.v1.Client.Observer
>(process:24491): mcd-DEBUG: mcd_client_registry_ready_cb: im.telepathy.v1.Client.Logger
>(process:24491): mcd-DEBUG: _mcd_client_registry_dec_startup_lock: 1 -> 0
>(process:24491): mcd-DEBUG: mcd_dispatcher_client_registry_ready_cb: All initial clients have been inspected
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.AbiWord:
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 channel filters
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 2 capability tokens:
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Foo
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities:     com.example.Bar
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: im.telepathy.v1.Client.Logger:
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 channel filters
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: - 0 capability tokens:
>(process:24491): mcd-DEBUG: _mcd_client_proxy_dup_handler_capabilities: -end-
>(process:24491): mcd-DEBUG: connectivity_monitor_nm_state_change_cb: New NetworkManager network state 70 (stable state)
>(process:24491): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24491): mcd-DEBUG: get_usable_accounts: called
>(process:24491): mcd-DEBUG: get_unusable_accounts: called
>(process:24491): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24491): mcd-DEBUG: dbusprop_get_all: im.telepathy.v1.AccountManager
>(process:24491): mcd-DEBUG: get_usable_accounts: called
>(process:24491): mcd-DEBUG: get_unusable_accounts: called
>(process:24491): mcd-DEBUG: mcd_dbus_get_interfaces: called
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(im.telepathy.v1.ConnectionManager.fakecm, :1.0 -> )
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(net.connman, :1.0 -> )
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(org.freedesktop.NetworkManager, :1.0 -> )
>(process:24491): tp-glib/proxy-DEBUG: noc_idle_context_invoke: NameOwnerChanged(:1.0, :1.0 -> )
>** Message: Got disconnected from the session bus
>(process:24491): mcd-DEBUG: _mcd_operation_abort: Operation abort received, aborting all children
>** (process:24491): DEBUG: McdService aborted, unreffing it
>(process:24491): mcd-DEBUG: Object Hierarchy of object 0xc51c20
>(process:24491): mcd-DEBUG: [
>(process:24491): mcd-DEBUG:     McdService (0xc51c20): 2
>(process:24491): mcd-DEBUG: ]
>(process:24491): mcd-DEBUG: mcd_inhibit_release: 0xc4dc60 (fd -1): 1 -> 0
>(process:24491): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.AbiWord'
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xcb20f0
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xcb20f0: Proxy unreferenced
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xcb20f0
>(process:24491): tp-glib/proxy-DEBUG: _tp_dbus_daemon_stop_watching: Removing match rule type='signal',sender='org.freedesktop.DBus',path='/org/freedesktop/DBus',interface='org.freedesktop.DBus',member='NameOwnerChanged',arg0='im.telepathy.v1.Client.Logger'
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xcb21e0
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xcb21e0: Proxy unreferenced
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xcb21e0
>(process:24491): mcd-DEBUG: _mcd_operation_dispose: operation disposed
>(process:24491): mcd-DEBUG: _mcd_mission_dispose: mission disposed 0xc51c20
>(process:24491): mcd-DEBUG: _mcd_mission_finalize: mission finalized 0xc51c20
>(process:24491): tp-glib/proxy-DEBUG: tp_proxy_iface_destroyed_cb: 0xc559f0
>g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g-io-error-quark, 0). Exiting.
>===== log file: test.log =====
>Temporary bus daemon is unix:abstract=/tmp/dbus-YMCKNCIZBP,guid=9974e18c2418c3f4577ec51752de946d
>Temporary bus daemon PID is 24409
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'org.freedesktop.NetworkManager', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'org.freedesktop.NetworkManager']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'net.connman', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'net.connman']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [{u'State': 70L}]
>- interface: 'org.freedesktop.NetworkManager'
>- path: '/org/freedesktop/NetworkManager'
>- signal: 'PropertiesChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [70L]
>- interface: 'org.freedesktop.NetworkManager'
>- path: '/org/freedesktop/NetworkManager'
>- signal: 'StateChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'State', u'online']
>- interface: 'net.connman.Manager'
>- path: '/'
>- signal: 'PropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'org.freedesktop.NetworkManager', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'org.freedesktop.NetworkManager']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'net.connman', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'net.connman']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [{u'State': 70L}]
>- interface: 'org.freedesktop.NetworkManager'
>- path: '/org/freedesktop/NetworkManager'
>- signal: 'PropertiesChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [70L]
>- interface: 'org.freedesktop.NetworkManager'
>- path: '/org/freedesktop/NetworkManager'
>- signal: 'StateChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'State', u'online']
>- interface: 'net.connman.Manager'
>- path: '/'
>- signal: 'PropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.1', u'', u':1.1']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.2', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.1', u'', u':1.1']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.2', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.3', u'', u':1.3']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.3', u'', u':1.3']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.3'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.3'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 55.356 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 55.879 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.2']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 56.107 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ConnectionManager.fakecm', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ConnectionManager.fakecm']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ConnectionManager.fakecm', u'', u':1.0']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ConnectionManager.fakecm']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameAcquired'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [{u'account': u'dontdivert@example.com',
>  u'password': u'secrecy',
>  u'snakes': 23L}]
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'im.telepathy.v1.Protocol'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm/fakeprotocol, iface: im.telepathy.v1.Protocol, member: IdentifyAccount dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'IdentifyAccount'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm/fakeprotocol')
>- raw_args: [dbus.Dictionary({dbus.String(u'account'): dbus.String(u'dontdivert@example.com', variant_level=1), dbus.String(u'password'): dbus.String(u'secrecy', variant_level=1), dbus.String(u'snakes'): dbus.UInt32(23L, variant_level=1)}, signature=dbus.Signature('sv'))]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [{u'account': u'dontdivert@example.com',
>  u'password': u'secrecy',
>  u'snakes': 23L}]
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'im.telepathy.v1.Protocol'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm/fakeprotocol, iface: im.telepathy.v1.Protocol, member: IdentifyAccount dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'IdentifyAccount'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm/fakeprotocol')
>- raw_args: [dbus.Dictionary({dbus.String(u'account'): dbus.String(u'dontdivert@example.com', variant_level=1), dbus.String(u'password'): dbus.String(u'secrecy', variant_level=1), dbus.String(u'snakes'): dbus.UInt32(23L, variant_level=1)}, signature=dbus.Signature('sv'))]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.2'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',
> True]
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountUsabilityChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',
> True]
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountUsabilityChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 6.504 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-return
>- method: 'CreateAccount'
>- subqueue: 'dbus'
>- subtype: 'return'
>- value: ('/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',)
>got event:
>- type dbus-return
>- method: 'CreateAccount'
>- subqueue: 'dbus'
>- subtype: 'return'
>- value: ('/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',)
>handled, took 7.797 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [{u'Usable': True}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [{u'Usable': True}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 16.947 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [{u'AutomaticPresence': (4L, u'xa', u'never online'),
>  u'ConnectAutomatically': True,
>  u'DisplayName': u'Work account',
>  u'Icon': u'im-jabber',
>  u'Nickname': u'Joe Bloggs'}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [{u'AutomaticPresence': (4L, u'xa', u'never online'),
>  u'ConnectAutomatically': True,
>  u'DisplayName': u'Work account',
>  u'Icon': u'im-jabber',
>  u'Nickname': u'Joe Bloggs'}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.2', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.1', u':1.1', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.3', u':1.3', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 5001.521 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.2', u':1.2', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.1', u':1.1', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.3', u':1.3', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.4', u'', u':1.4']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.5', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.4', u'', u':1.4']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.5', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.6', u'', u':1.6']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.6', u'', u':1.6']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.6'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.6'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 52.513 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 54.068 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.5'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.5']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 57.140 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0']
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountRemoved'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0']
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountRemoved'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 0.884 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 1.101 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.5', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.4', u':1.4', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.6', u':1.6', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 4906.018 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.5', u':1.5', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.4', u':1.4', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.6', u':1.6', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.7', u'', u':1.7']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.7', u'', u':1.7']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.8', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.8', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.9', u'', u':1.9']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.9', u'', u':1.9']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.9'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.9'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 63.247 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 65.874 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'im.telepathy.v1.ConnectionManager']
>- destination: 'im.telepathy.v1.ConnectionManager.fakecm'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /im/telepathy/v1/ConnectionManager/fakecm, iface: org.freedesktop.DBus.Properties, member: GetAll dest: im.telepathy.v1.ConnectionManager.fakecm>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/im/telepathy/v1/ConnectionManager/fakecm')
>- raw_args: [dbus.String(u'im.telepathy.v1.ConnectionManager')]
>- sender: ':1.8'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.8']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 71.657 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',
> False]
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountUsabilityChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0',
> False]
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountUsabilityChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [{u'Parameters': {u'account': u'dontdivert@example.com', u'snakes': 42L},
>  u'Usable': False}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [{u'Parameters': {u'account': u'dontdivert@example.com', u'snakes': 42L},
>  u'Usable': False}]
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'AccountPropertyChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 10.911 ms
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0priority']
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountRemoved'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0priority'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: ['/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0priority']
>- interface: 'im.telepathy.v1.AccountManager'
>- path: '/im/telepathy/v1/AccountManager'
>- signal: 'AccountRemoved'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0priority'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Account'
>- path: '/im/telepathy/v1/Account/fakecm/fakeprotocol/dontdivert_40example_2ecom0'
>- signal: 'Removed'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.8', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.7', u':1.7', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.9', u':1.9', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 4907.497 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.8', u':1.8', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.7', u':1.7', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.9', u':1.9', u'']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.10', u'', u':1.10']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.11', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.10', u'', u':1.10']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u':1.11', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u':1.12', u'', u':1.12']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u':1.12', u'', u':1.12']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.12'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: []
>- destination: ':1.0'
>- handled: True
>- interface: 'net.connman.Manager'
>- message: <dbus.lowlevel.MethodCallMessage path: /, iface: net.connman.Manager, member: GetProperties dest: :1.0>
>- method: 'GetProperties'
>- path: dbus.ObjectPath('/')
>- raw_args: []
>- sender: ':1.12'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>Adding to queue
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>got event:
>- type dbus-method-call
>- args: [u'org.freedesktop.NetworkManager']
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.DBus.Properties'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.DBus.Properties, member: GetAll dest: org.freedesktop.NetworkManager>
>- method: 'GetAll'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: [dbus.String(u'org.freedesktop.NetworkManager')]
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetDevices dest: org.freedesktop.NetworkManager>
>- method: 'GetDevices'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-method-call
>- args: []
>- destination: 'org.freedesktop.NetworkManager'
>- handled: True
>- interface: 'org.freedesktop.NetworkManager'
>- message: <dbus.lowlevel.MethodCallMessage path: /org/freedesktop/NetworkManager, iface: org.freedesktop.NetworkManager, member: GetPermissions dest: org.freedesktop.NetworkManager>
>- method: 'GetPermissions'
>- path: dbus.ObjectPath('/org/freedesktop/NetworkManager')
>- raw_args: []
>- sender: ':1.11'
>- subqueue: 'dbus'
>- subtype: 'method-call'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Listing'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>Adding to queue
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Inactive'
>- subqueue: 'dbus'
>- subtype: 'signal'
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.ChannelDispatcher', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 51.397 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: []
>- interface: 'im.telepathy.v1.Test.DBusAccountPlugin'
>- path: '/im/telepathy/v1/Test/DBusAccountPlugin'
>- signal: 'Ready'
>- subqueue: 'dbus'
>- subtype: 'signal'
>not handled
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.AccountManager', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 51.929 ms
>
>Waiting for event on: dbus
>got event:
>- type dbus-signal
>- args: [u'im.telepathy.v1.MissionControl6', u'', u':1.11']
>- interface: 'org.freedesktop.DBus'
>- path: '/org/freedesktop/DBus'
>- signal: 'NameOwnerChanged'
>- subqueue: 'dbus'
>- subtype: 'signal'
>handled, took 52.310 ms
>
>Traceback (most recent call last):
>  File "/home/cassidy/dev/telepathy-mission-control/tests/twisted/mctest.py", line 151, in exec_test_deferred
>    fun(queue, bus, mc, **kwargs)
>  File "/home/cassidy/dev/telepathy-mission-control/tests/twisted/account-storage/default-keyring-storage.py", line 304, in test
>    assert not os.path.exists(old_key_file_name)
>AssertionError
>Killing temporary bus daemon: 24409
>===== end of log files for account-storage/default-keyring-storage.py =====
>Tests run: 1; tests failed: 1
>make: *** [check-twisted] Error 1

Actions: View

Attachments on bug 73881: 92522 | 92580

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.