Bug 51283

Summary: mcd-CRITICAL **: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
Product: Telepathy Reporter: Guillaume Desmottes <guillaume.desmottes>
Component: mission-controlAssignee: Telepathy bugs list <telepathy-bugs>
Status: RESOLVED MOVED QA Contact: Telepathy bugs list <telepathy-bugs>
Severity: normal    
Priority: medium CC: bigon, john.brooks
Version: git master   
Hardware: Other   
OS: All   
Whiteboard:
i915 platform: i915 features:
Attachments: MC logs
test for this assertion

Description Guillaume Desmottes 2012-06-21 01:08:51 UTC
I get this when connecting a gabble account with MC master.


(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b4a0
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b4a0
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_interfaces: 0x81b4a0
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b4a0
(process:8823): tp-glib/groups-DEBUG: _tp_channel_get_group_properties: 0x81b4a0
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x81b4a0: org.freedesktop.Telepathy.Channel.Interface.Group DBusGProxy is 0x816960
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x81b4a0: org.freedesktop.DBus.Properties DBusGProxy is 0x80af30
(process:8823): tp-glib/proxy-DEBUG: request_is_complete: 0x81b4a0: calling callback for tp-channel-feature-core
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x81b4a0: core features not ready yet, nothing prepared
(process:8823): mcd-DEBUG: _mcd_mission_set_parent: child = 0x81c6a0, parent = 0x841280
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: unrequested channel 0x81c6a0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/4
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: One channel, which cannot be handled - making a CDO anyway, to get Observers run
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x81c6a0, 3
(process:8823): mcd-DEBUG: _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x81c6a0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/4
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: do67/0x80d240: needs_approval=T
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/4
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_init: 0x808f30
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_new: 0x808f30 (for 0x80d240)
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: do67 0x80d240
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Running observers
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: All necessary observers invoked
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Checking finished/locks
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_observers_finished: 0x808f30
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_close_as_undispatchable: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: Result: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: do67/0x80d240 has finished
(process:8823): mcd-DEBUG: mcd_dispatch_operation_actually_finish: do67/0x80d240: finished
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x81c6a0, 6
(process:8823): mcd-DEBUG: _mcd_tp_channel_should_close: Not destroying 0x81b4a0:/org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/4, it's a ContactList
(process:8823): mcd-DEBUG: plugin_do_finalize: 0x808f30
(process:8823): mcd-DEBUG: on_new_channels: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/5
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.ChannelType" => "org.freedesktop.Telepathy.Channel.Type.ContactList"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandleType" => 4
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorHandle" => 0
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetID" => "test"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorID" => ""
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Interfaces" => ["org.freedesktop.Telepathy.Channel.Interface.Group"]
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandle" => 5
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Requested" => FALSE
(process:8823): tp-glib/channel-DEBUG: tp_channel_init: 0x81b320
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x81b320: request 0x723440 represents core features on TpChannel
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x81b320: org.freedesktop.Telepathy.Channel DBusGProxy is 0x80ad00
(process:8823): tp-glib/channel-DEBUG: tp_channel_constructor: 0x81b320: constructed with channel type "org.freedesktop.Telepathy.Channel.Type.ContactList", handle #5 of type 4
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_handle: 0x81b320: handle already known to be 5 of type 4
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_identifier: 0x81b320: identifier already known to be test
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_channel_type: 0x81b320: channel type org.freedesktop.Telepathy.Channel.Type.ContactList already determined
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_interfaces: 0x81b320
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x81b320
(process:8823): tp-glib/groups-DEBUG: _tp_channel_get_group_properties: 0x81b320
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x81b320: org.freedesktop.Telepathy.Channel.Interface.Group DBusGProxy is 0x80ade0
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x81b320: org.freedesktop.DBus.Properties DBusGProxy is 0x7ffb30
(process:8823): tp-glib/proxy-DEBUG: request_is_complete: 0x81b320: calling callback for tp-channel-feature-core
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x81b320: core features not ready yet, nothing prepared
(process:8823): mcd-DEBUG: _mcd_mission_set_parent: child = 0x82cea0, parent = 0x841280
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: unrequested channel 0x82cea0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/5
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: One channel, which cannot be handled - making a CDO anyway, to get Observers run
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x82cea0, 3
(process:8823): mcd-DEBUG: _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x82cea0 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/5
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: do68/0x80d020: needs_approval=T
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/5
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_init: 0x819520
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_new: 0x819520 (for 0x80d020)
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: do68 0x80d020
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Running observers
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: All necessary observers invoked
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Checking finished/locks
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_observers_finished: 0x819520
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_close_as_undispatchable: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: Result: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: do68/0x80d020 has finished
(process:8823): mcd-DEBUG: mcd_dispatch_operation_actually_finish: do68/0x80d020: finished
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x82cea0, 6
(process:8823): mcd-DEBUG: _mcd_tp_channel_should_close: Not destroying 0x81b320:/org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/5, it's a ContactList
(process:8823): mcd-DEBUG: plugin_do_finalize: 0x819520
(process:8823): mcd-DEBUG: on_new_channels: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/6
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.ChannelType" => "org.freedesktop.Telepathy.Channel.Type.ContactList"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandleType" => 4
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorHandle" => 0
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetID" => "Ubuntu"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorID" => ""
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Interfaces" => ["org.freedesktop.Telepathy.Channel.Interface.Group"]
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandle" => 6
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Requested" => FALSE
(process:8823): tp-glib/channel-DEBUG: tp_channel_init: 0x7fd690
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_constructor: 0x7fd690: request 0x7e5b40 represents core features on TpChannel
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x7fd690: org.freedesktop.Telepathy.Channel DBusGProxy is 0x814b20
(process:8823): tp-glib/channel-DEBUG: tp_channel_constructor: 0x7fd690: constructed with channel type "org.freedesktop.Telepathy.Channel.Type.ContactList", handle #6 of type 4
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_handle: 0x7fd690: handle already known to be 6 of type 4
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_identifier: 0x7fd690: identifier already known to be Ubuntu
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_channel_type: 0x7fd690: channel type org.freedesktop.Telepathy.Channel.Type.ContactList already determined
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_get_interfaces: 0x7fd690
(process:8823): tp-glib/channel-DEBUG: _tp_channel_continue_introspection: 0x7fd690
(process:8823): tp-glib/groups-DEBUG: _tp_channel_get_group_properties: 0x7fd690
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x7fd690: org.freedesktop.Telepathy.Channel.Interface.Group DBusGProxy is 0x7850b0
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_borrow_interface_by_id: 0x7fd690: org.freedesktop.DBus.Properties DBusGProxy is 0x818430
(process:8823): tp-glib/proxy-DEBUG: request_is_complete: 0x7fd690: calling callback for tp-channel-feature-core
(process:8823): tp-glib/proxy-DEBUG: tp_proxy_poll_features: 0x7fd690: core features not ready yet, nothing prepared
(process:8823): mcd-DEBUG: _mcd_mission_set_parent: child = 0x82ad20, parent = 0x841280
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: unrequested channel 0x82ad20 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/6
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: One channel, which cannot be handled - making a CDO anyway, to get Observers run
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x82ad20, 3
(process:8823): mcd-DEBUG: _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0x82ad20 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/6
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: do69/0x80d350: needs_approval=T
(process:8823): mcd-DEBUG: mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/6
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_init: 0x814d60
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_new: 0x814d60 (for 0x80d350)
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: do69 0x80d350
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Running observers
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: All necessary observers invoked
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Checking finished/locks
(process:8823): mcd-DEBUG: _mcd_plugin_dispatch_operation_observers_finished: 0x814d60
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_close_as_undispatchable: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: Result: No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_finish: do69/0x80d350 has finished
(process:8823): mcd-DEBUG: mcd_dispatch_operation_actually_finish: do69/0x80d350: finished
(process:8823): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): No possible handlers, giving up
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x82ad20, 6
(process:8823): mcd-DEBUG: _mcd_tp_channel_should_close: Not destroying 0x7fd690:/org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/6, it's a ContactList
(process:8823): mcd-DEBUG: plugin_do_finalize: 0x814d60
(process:8823): mcd-DEBUG: on_new_channels: /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/1
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.ChannelType" => "org.freedesktop.Telepathy.Channel.Type.ContactList"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandleType" => 4
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorHandle" => 0
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetID" => "Collabora"
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorID" => ""
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Interfaces" => ["org.freedesktop.Telepathy.Channel.Interface.Group"]
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandle" => 1
(process:8823): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Requested" => FALSE
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: unrequested channel 0x752240 (only): /org/freedesktop/Telepathy/Connection/gabble/jabber/guillaume_2edesmottes_40collabora_2eco_2euk_2fcb11d944/Group/1
(process:8823): mcd-DEBUG: _mcd_dispatcher_take_channels: One channel, which cannot be handled - making a CDO anyway, to get Observers run
(process:8823): mcd-DEBUG: _mcd_channel_set_status: 0x752240, 3

(process:8823): mcd-CRITICAL **: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed



#0  0x00007ffff6e7bde9 in g_logv (log_domain=0x44c223 "mcd", log_level=G_LOG_LEVEL_CRITICAL, 
    format=0x7ffff6efe9c0 "%s: assertion `%s' failed", args1=0x7fffffffd188) at gmessages.c:758
        domain = 0x0
        data = 0x0
        depth = 1
        log_func = 0x40c100 <tp_debug_sender_log_handler@plt>
        domain_fatal_mask = 5
        masquerade_fatal = 0
        test_level = 10
        was_fatal = 0
        was_recursion = 0
        i = 3
#1  0x00007ffff6e7bedd in g_log (log_domain=0x44c223 "mcd", log_level=G_LOG_LEVEL_CRITICAL, 
    format=0x7ffff6efe9c0 "%s: assertion `%s' failed") at gmessages.c:792
        args = {{gp_offset = 24, fp_offset = 48, overflow_arg_area = 0x7fffffffd260, reg_save_area = 0x7fffffffd1a0}}
#2  0x00007ffff6e7bf1e in g_return_if_fail_warning (log_domain=0x44c223 "mcd", pretty_function=0x44cab0 "_mcd_channel_set_status", 
    expression=0x44c5c0 "channel->priv->status != MCD_CHANNEL_STATUS_FAILED") at gmessages.c:801
No locals.
#3  0x000000000042021e in _mcd_channel_set_status (channel=0x752240, status=MCD_CHANNEL_STATUS_DISPATCHING) at mcd-channel.c:733
        __PRETTY_FUNCTION__ = "_mcd_channel_set_status"
#4  0x000000000041bcd1 in _mcd_dispatcher_take_channels (dispatcher=0x690d80, channels=0x7db260, requested=0, only_observe=0)
    at mcd-dispatcher.c:1032
        list = 0x7db260
        tp_channels = 0x72bcc0
        possible_handlers = 0x0
        request = 0x0
        internal_request = 0
        __PRETTY_FUNCTION__ = "_mcd_dispatcher_take_channels"
#5  0x0000000000415f67 in on_new_channels (proxy=0x7faa20, channels=0x7a72e0, user_data=0x8412c0, weak_object=0x841280)
    at mcd-connection.c:1301
        connection = 0x841280
        priv = 0x8412c0
        channel = 0x752240
        channel_list = 0x7db260
        requested = 0
        only_observe = 0
        i = 1
        __PRETTY_FUNCTION__ = "on_new_channels"
#6  0x00007ffff7a769ae in _tp_cli_connection_interface_requests_invoke_callback_for_new_channels (tpproxy=0x7faa20, error=0x0, 
---Type <return> to continue, or q <return> to quit---
    args=0x7d52e0, generic_callback=0x415c48 <on_new_channels>, user_data=0x8412c0, weak_object=0x841280)
    at _gen/tp-cli-connection-body.h:16152
        callback = 0x415c48 <on_new_channels>
#7  0x00007ffff7aef857 in tp_proxy_signal_invocation_run (p=0x7d5460) at proxy-signals.c:268
        invocation = 0x7d5460
        popped = 0x7d5460
        __PRETTY_FUNCTION__ = "tp_proxy_signal_invocation_run"
#8  0x00007ffff6e74a11 in g_idle_dispatch (source=0x7ca230, callback=0x7ffff7aef7b9 <tp_proxy_signal_invocation_run>, user_data=0x7d5460)
    at gmain.c:4657
No locals.
#9  0x00007ffff6e722b9 in g_main_dispatch (context=0x6795e0) at gmain.c:2539
        dispatch = 0x7ffff6e749c5 <g_idle_dispatch>
        was_in_call = 0
        user_data = 0x7d5460
        callback = 0x7ffff7aef7b9 <tp_proxy_signal_invocation_run>
        cb_funcs = 0x7ffff7166e00
        cb_data = 0x7af730
        need_destroy = 6781600
        current_source_link = {data = 0x7ca230, next = 0x0}
        source = 0x7ca230
        current = 0x70a340
        i = 0
        __PRETTY_FUNCTION__ = "g_main_dispatch"
#10 0x00007ffff6e72f7e in g_main_context_dispatch (context=0x6795e0) at gmain.c:3075
No locals.
#11 0x00007ffff6e73161 in g_main_context_iterate (context=0x6795e0, block=1, dispatch=1, self=0x705f60) at gmain.c:3146
        max_priority = -100
        timeout = 0
        some_ready = 1
        nfds = 0
        allocated_nfds = 5
        fds = 0x67e980
#12 0x00007ffff6e73591 in g_main_loop_run (loop=0x67eb80) at gmain.c:3340
        self = 0x705f60
        __PRETTY_FUNCTION__ = "g_main_loop_run"
#13 0x0000000000410f36 in mcd_service_run (self=0x67b120) at mcd-service.c:192
No locals.
#14 0x000000000040e98c in main (argc=1, argv=0x7fffffffd868) at mc-server.c:189
        act = {__sigaction_handler = {sa_handler = 0x40e574 <signal_handler>, sa_sigaction = 0x40e574 <signal_handler>}, sa_mask = {
---Type <return> to continue, or q <return> to quit---
            __val = {0 <repeats 16 times>}}, sa_flags = 0, sa_restorer = 0x7ffff6efc307}
        empty_mask = {__val = {0 <repeats 16 times>}}
Comment 1 Xavier Claessens 2012-07-09 14:11:22 UTC
Created attachment 64020 [details]
MC logs
Comment 2 Jonny Lamb 2012-07-10 08:48:10 UTC
Created attachment 64057 [details]
test for this assertion

I'm torn on this. The real bug is gabble announcing the same channel twice. MC asserting like this isn't great, but tbh it's an assertion and shouldn't make MC exit when running normally. I'm not sure whether anything should change in MC..?

I've attached a test which reproduces this bug. I added this StubbornChannel class because I wanted to make sure the channel wasn't closed. This is a lot easier in practice with Tubes/ContactList channels because MC won't close them after being marked as undispatchable.
Comment 3 Peter Weber 2012-08-06 14:30:37 UTC
Hello! Looks like I'm facing this bug also on Archlinux and Fedora.

mcd-CRITICAL: 08/06/2012 12:48:55.370529: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 15:49:36.317723: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 15:52:36.517472: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 15:56:43.897310: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 15:58:54.351641: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:01:13.465260: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:05:30.144090: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:09:05.35250: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:11:16.179349: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:14:00.992227: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:16:13.157604: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:19:33.578233: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:23:43.517292: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
mcd-CRITICAL: 08/06/2012 16:25:55.266416: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
-WARNING: 08/06/2012 12:49:44.130134: Metadata for error domain "geoclue-error-quark" already registered
eds-WARNING: 08/06/2012 12:49:44.400727: edsf-persona-store.vala:2078: Error in address book view query: GDBus.Error:org.gnome.evolution.dataserver.AddressBook.AuthenticationRequired: Authentication Required
eds-WARNING: 08/06/2012 12:49:44.400773: edsf-persona-store.vala:2088: Error is considered unrecoverable. Removing persona store.
eds-WARNING: 08/06/2012 12:49:44.402965: edsf-persona-store.vala:2078: Error in address book view query: GDBus.Error:org.gnome.evolution.dataserver.AddressBook.AuthenticationRequired: Authentication Required
mcd-CRITICAL: 08/06/2012 16:28:13.266863: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed



Empathy shows every time the assertion fails a new notification in the notification bar. Is it possible to switch of the notification (temporariley), because it is quite distracting?
Comment 4 Peter Weber 2012-09-06 10:44:01 UTC
(In reply to comment #3)

On may Archlinux machine this was caused by a static IP which was advertised by DHCP at the same time. So the MCD_CHANNEL_STATUS_FAILED was perfectly right and without this message I would maybe still suffer random connection losts. Whole thing was my own mistake.

by the way:
I still don't know whats the problem on the Fedora machine, but there are several VMs in the network. I guess maybe their happens someting similar (VM simulates same MAC, gets same IP from DHCP, stole my IP -> connection lost).

What I'm still seeing is sometimes a warning about lost XMPP-Connection directly after login. Maybe this is really a problem of Telepathy.

Sorry :-)
Comment 5 John Brooks 2013-04-29 04:58:41 UTC
Also reproduced on connect with gabble apparently announcing the same ContactList channel twice:

(process:3062): mcd-DEBUG: on_new_channels: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.ChannelType" => "org.freedesktop.Telepathy.Channel.Type.ContactList"
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandleType" => 4
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorHandle" => 0
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetID" => "Facebook Friends"
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorID" => ""
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Interfaces" => ["org.freedesktop.Telepathy.Channel.Interface.Group"]
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandle" => 1
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Requested" => FALSE
(process:3062): mcd-DEBUG: _mcd_mission_set_parent: child = 0xc3460, parent = 0xd2968
(process:3062): mcd-DEBUG: _mcd_dispatcher_add_channel: unrequested channel 0xc3460: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: _mcd_dispatcher_add_channel: Channel cannot be handled - making a CDO anyway, to get Observers run
(process:3062): mcd-DEBUG: _mcd_channel_set_status: 0xc3460, 3
(process:3062): mcd-DEBUG: _mcd_dispatcher_enter_state_machine: new dispatch operation for unrequested channel 0xc3460: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: mcd_dispatch_operation_constructor: do7/0x111c48: needs_approval=T
(process:3062): mcd-DEBUG: mcd_dispatch_operation_constructor: Channel: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: _mcd_plugin_dispatch_operation_init: 0x11ae60
(process:3062): mcd-DEBUG: _mcd_plugin_dispatch_operation_new: 0x11ae60 (for 0x111c48)
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_run_clients: do7 0x111c48
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Running observers
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_run_clients: All necessary observers invoked
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_run_clients: Checking finished/locks
(process:3062): mcd-DEBUG: _mcd_plugin_dispatch_operation_observers_finished: 0x11ae60
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: No possible handlers, giving up
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_close_as_undispatchable: No possible handlers, giving up
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_finish: Result: No possible handlers, giving up
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_finish: do7/0x111c48 has finished
(process:3062): mcd-DEBUG: mcd_dispatch_operation_actually_finish: do7/0x111c48: finished
(process:3062): mcd-DEBUG: _mcd_dispatch_operation_check_client_locks: already finished (or finishing): No possible handlers, giving up
(process:3062): mcd-DEBUG: _mcd_channel_set_status: 0xc3460, 6
(process:3062): mcd-DEBUG: _mcd_tp_channel_should_close: Not destroying 0x1111e8:/org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1, it's a ContactList
(process:3062): mcd-DEBUG: plugin_do_finalize: 0x11ae60
(process:3062): mcd-DEBUG: on_new_channels: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.ChannelType" => "org.freedesktop.Telepathy.Channel.Type.ContactList"
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandleType" => 4
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorHandle" => 0
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetID" => "Facebook Friends"
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.InitiatorID" => ""
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Interfaces" => ["org.freedesktop.Telepathy.Channel.Interface.Group"]
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.TargetHandle" => 1
(process:3062): mcd-DEBUG: on_new_channels:   "org.freedesktop.Telepathy.Channel.Requested" => FALSE
(process:3062): mcd-DEBUG: _mcd_dispatcher_add_channel: unrequested channel 0xc3460: /org/freedesktop/Telepathy/Connection/gabble/jabber/chat_2efacebook_2ecom_2f46aef73a_5f0x115058/Group/1
(process:3062): mcd-DEBUG: _mcd_dispatcher_add_channel: Channel cannot be handled - making a CDO anyway, to get Observers run
(process:3062): mcd-DEBUG: _mcd_channel_set_status: 0xc3460, 3

(process:3062): mcd-CRITICAL **: _mcd_channel_set_status: assertion `channel->priv->status != MCD_CHANNEL_STATUS_FAILED' failed
Comment 6 Simon McVittie 2013-04-29 10:21:55 UTC
Which Mission Control version (release or exact git commit) can people reproduce this with?
Comment 7 John Brooks 2013-04-29 18:27:53 UTC
(In reply to comment #6)
> Which Mission Control version (release or exact git commit) can people
> reproduce this with?

For me, mission-control 5.14.0, telepathy-gabble 0.17.3. Occurs for facebook and google talk accounts.
Comment 8 GitLab Migration User 2019-12-03 20:12:05 UTC
-- GitLab Migration Automatic Message --

This bug has been migrated to freedesktop.org's GitLab instance and has been closed from further activity.

You can subscribe and participate further through the new bug through this link to our GitLab instance: https://gitlab.freedesktop.org/telepathy/telepathy-mission-control/issues/59.

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.