(process:19315): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0x121a800
(process:19315): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0x121a800: Proxy unreferenced
(process:19315): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0x121a800
(process:19315): gabble-DEBUG: 2012-05-07T17:49:03.481778Z.481778: gabble_plugin_loader_probe (/home/smcv/src/fdo/gabble/src/plugin-loader.c:134): probing /home/smcv/build/gabble/debug/plugins/.libs
** (process:19315): DEBUG: 2012-05-07T17:49:03.482179Z.482179: gabble_plugin_create: loaded
(process:19315): gabble-DEBUG: 2012-05-07T17:49:03.482230Z.482230: plugin_loader_try_to_load (/home/smcv/src/fdo/gabble/src/plugin-loader.c:99): loaded 'XMPP console' version 0.16.999.1 (/home/smcv/build/gabble/debug/plugins/.libs/libconsole.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Console
** (process:19315): DEBUG: 2012-05-07T17:49:03.482503Z.482503: gabble_plugin_create: loaded
(process:19315): gabble-DEBUG: 2012-05-07T17:49:03.482547Z.482547: plugin_loader_try_to_load (/home/smcv/src/fdo/gabble/src/plugin-loader.c:99): loaded 'Gateway registration plugin' version 0.16.999.1 (/home/smcv/build/gabble/debug/plugins/.libs/libgateways.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Gateways
** (process:19315): DEBUG: 2012-05-07T17:49:03.482833Z.482833: test_plugin_init: 0x1210b00
(process:19315): gabble-DEBUG: 2012-05-07T17:49:03.482868Z.482868: plugin_loader_try_to_load (/home/smcv/src/fdo/gabble/src/plugin-loader.c:99): loaded 'Sidecar test plugin' version 0.16.999.1 (/home/smcv/build/gabble/debug/plugins/.libs/libtest.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Test, org.freedesktop.Telepathy.Gabble.Plugin.Test.Props, org.freedesktop.Telepathy.Gabble.Plugin.Test.Buggy, org.freedesktop.Telepathy.Gabble.Plugin.Test.IQ
(telepathy-gabble:19315): tp-glib-DEBUG: 2012-05-07T17:49:03.484472Z.484472: started version 0.16.999.1 (telepathy-glib version 0.18.1)
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.484957Z.484957: tp_base_protocol_sanitize_parameters: using specified value for account: "test@localhost/jingle-share/test-send-file-send-before-accept.py"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.484999Z.484999: tp_base_protocol_sanitize_parameters: using specified value for password: <secret>
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.485030Z.485030: tp_base_protocol_sanitize_parameters: using specified value for server: "localhost"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.485058Z.485058: tp_base_protocol_sanitize_parameters: using specified value for resource: "Resource"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.485097Z.485097: tp_base_protocol_sanitize_parameters: using specified value for port: 4242
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.485131Z.485131: tp_base_protocol_sanitize_parameters: using specified value for require-encryption: FALSE
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.485175Z.485175: tp_base_protocol_sanitize_parameters: using specified value for fallback-socks5-proxies: []
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.485699Z.485699: gabble_connection_class_init (/home/smcv/src/fdo/gabble/src/connection.c:1001): Initializing (GabbleConnectionClass *)0x1223190
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.485855Z.485855: tp_presence_mixin_class_init: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486036Z.486036: gabble_connection_init (/home/smcv/src/fdo/gabble/src/connection.c:564): Initializing (GabbleConnection *)0x124e010
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486097Z.486097: gabble_capabilities_init (/home/smcv/src/fdo/gabble/src/capabilities.c:242): 0x124e010
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486561Z.486561: gabble_roomlist_manager_constructed (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:209): 0x1213ac0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486634Z.486634: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e010:status-changed with context 0x12418c0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486741Z.486741: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e010:status-changed with context 0x1241980
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486834Z.486834: gabble_server_tls_manager_constructed (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:420): Server TLS Manager constructed
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.486867Z.486867: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e010:status-changed with context 0x1256120
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.487027Z.487027: test_plugin_create_channel_managers: plugin 0x1210b00 on connection 0x124e010
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.487212Z.487212: gabble_connection_constructor (/home/smcv/src/fdo/gabble/src/connection.c:432): Post-construction: (GabbleConnection *)0x124e010
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.487668Z.487668: tp_presence_mixin_init: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.487839Z.487839: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213b80:item-found with context 0x1256320
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.487887Z.487887: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e010:status-changed with context 0x126b020
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.487992Z.487992: gabble_connection_constructed (/home/smcv/src/fdo/gabble/src/connection.c:547): defaulted resource to 13cdc5f0
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.488470Z.488470: tp_base_connection_register: 0x124e010: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test_40localhost_2fResource; object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490540Z.490540: tp_base_protocol_sanitize_parameters: using specified value for account: "test1@localhost/jingle-share/test-send-file-send-before-accept.py"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490576Z.490576: tp_base_protocol_sanitize_parameters: using specified value for password: <secret>
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490605Z.490605: tp_base_protocol_sanitize_parameters: using specified value for server: "localhost"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490633Z.490633: tp_base_protocol_sanitize_parameters: using specified value for resource: "Resource"
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490663Z.490663: tp_base_protocol_sanitize_parameters: using specified value for port: 4242
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490692Z.490692: tp_base_protocol_sanitize_parameters: using specified value for require-encryption: FALSE
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:03.490729Z.490729: tp_base_protocol_sanitize_parameters: using specified value for fallback-socks5-proxies: []
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.490780Z.490780: gabble_connection_init (/home/smcv/src/fdo/gabble/src/connection.c:564): Initializing (GabbleConnection *)0x124e370
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.490812Z.490812: gabble_capabilities_init (/home/smcv/src/fdo/gabble/src/capabilities.c:242): 0x124e370
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.490965Z.490965: gabble_roomlist_manager_constructed (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:209): 0x1213d40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491014Z.491014: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e370:status-changed with context 0x126b500
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491077Z.491077: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e370:status-changed with context 0x126b080
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491125Z.491125: gabble_server_tls_manager_constructed (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:420): Server TLS Manager constructed
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491156Z.491156: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e370:status-changed with context 0x126b120
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.491293Z.491293: test_plugin_create_channel_managers: plugin 0x1210b00 on connection 0x124e370
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491427Z.491427: gabble_connection_constructor (/home/smcv/src/fdo/gabble/src/connection.c:432): Post-construction: (GabbleConnection *)0x124e370
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.491711Z.491711: tp_presence_mixin_init: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491859Z.491859: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213d80:item-found with context 0x126b760
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491900Z.491900: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x124e370:status-changed with context 0x126b700
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.491973Z.491973: gabble_connection_constructed (/home/smcv/src/fdo/gabble/src/connection.c:547): defaulted resource to 13cdc5f0
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.492375Z.492375: tp_base_connection_register: 0x124e370: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test1_40localhost_2fResource; object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.502746Z.502746: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2205): disabling SRV because "server" or "old-ssl" was specified or port was not 5222, will connect to localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.502815Z.502815: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2224): require-encryption is False; flipping ignore_ssl_errors to True
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.502871Z.502871: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2264): Start connecting
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.503097Z.503097: connector_connect_async: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:2314: host: localhost; port: 4242
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.505179Z.505179: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.505263Z.505263: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.505322Z.505322: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213b80:item-found with context 0x129fac0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.505387Z.505387: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213b80:done with context 0x129fb60
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.505432Z.505432: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.509750Z.509750: tcp_host_connected: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:937: HOST connection succeeded
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.510267Z.510267: xmpp_init: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1056: sending XMPP stream open to server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.510360Z.510360: wocky_xmpp_writer_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:298: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="localhost" version="1.0">

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.510481Z.510481: xmpp_init_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1077: waiting for stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.514984Z.514984: Parsing chunk: <stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' version='1.0' id='4baec63f0371c449'><stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>PLAIN</mechanism></mechanisms></stream:features>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515094Z.515094: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:431: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515128Z.515128: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515157Z.515157: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: id = '4baec63f0371c449' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515268Z.515268: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'
        * mechanism
            "PLAIN"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515320Z.515320: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1111: TCP Connection Established: : received XMPP version=1.0 stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515362Z.515362: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1126: waiting for feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515422Z.515422: xmpp_features_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1182: received feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515507Z.515507: sasl_request_auth: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1310: handing over control to SASL module
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515545Z.515545: wocky_auth_registry_select_handler: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-auth-registry.c:287: Choosing PLAIN as auth mechanism
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515620Z.515620: plain_initial_response: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-sasl-plain.c:165: Got username and password
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515715Z.515715: _write_node_tree: Serializing tree:
* auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' xmlns:wocky-zb='http://www.google.com/talk/protocol/auth' wocky-zb:client-uses-full-bind-result='true' mechanism='PLAIN'
    "AHRlc3QAcGFzcw=="
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.515779Z.515779: Writing xml: <auth wocky-zb:client-uses-full-bind-result="true" mechanism="PLAIN" xmlns:wocky-zb="http://www.google.com/talk/protocol/auth" xmlns="urn:ietf:params:xml:ns:xmpp-sasl">AHRlc3QAcGFzcw==</auth>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517746Z.517746: Parsing chunk: <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517804Z.517804: _end_element_ns: Received stanza
* success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517885Z.517885: auth_succeeded: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-sasl-auth.c:245: Authentication succeeded
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517923Z.517923: sasl_auth_done: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1345: SASL complete (success)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517952Z.517952: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.517994Z.517994: xmpp_init: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1056: sending XMPP stream open to server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.518030Z.518030: wocky_xmpp_writer_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:298: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="localhost" version="1.0">

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.518112Z.518112: xmpp_init_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1077: waiting for stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519734Z.519734: Parsing chunk: <stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' version='1.0' id='aa45cd2c72354ea'><stream:features><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></stream:features>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519790Z.519790: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:431: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519822Z.519822: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519851Z.519851: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: id = 'aa45cd2c72354ea' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519917Z.519917: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519959Z.519959: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1111: Authentication Completed: : received XMPP version=1.0 stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.519989Z.519989: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1126: waiting for feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.520042Z.520042: xmpp_features_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1182: received feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.520103Z.520103: iq_bind_resource: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1845: sending bind iq set stanza
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.520144Z.520144: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='2830520078'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
        * resource
            "Resource"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.520188Z.520188: Writing xml: <iq type="set" id="2830520078"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource>Resource</resource></bind></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.520267Z.520267: iq_bind_resource_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1868: bind iq set stanza sent
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.522764Z.522764: Parsing chunk: <iq type='result' id='2830520078'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>test@localhost/Resource</jid></bind></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.522839Z.522839: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='2830520078'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
        * jid
            "test@localhost/Resource"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.522886Z.522886: iq_bind_resource_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1886: bind iq response stanza received
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.522949Z.522949: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='2563522914'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.522990Z.522990: Writing xml: <iq type="set" id="2563522914"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.523929Z.523929: Parsing chunk: <iq type='result' id='2563522914'><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.523998Z.523998: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='2563522914'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.524047Z.524047: connector_connected (/home/smcv/src/fdo/gabble/src/connection.c:1931): connected (jid: test@localhost/Resource)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.524319Z.524319: wocky_ping_set_property: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-ping.c:87: updated ping interval to 30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.524402Z.524402: gabble_roster_porter_available_cb (/home/smcv/src/fdo/gabble/src/roster.c:1768): adding callbacks
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.524465Z.524465: porter_available_cb (/home/smcv/src/fdo/gabble/src/im-factory.c:515): adding callbacks
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.524702Z.524702: test_channel_manager_porter_available_cb: now we have a porter: 0x12c1890
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.524999Z.524999: connector_connected (/home/smcv/src/fdo/gabble/src/connection.c:1996): Created self handle 1, our JID is test@localhost/Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525071Z.525071: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource Resource with serial 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525103Z.525103: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525132Z.525132: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 1, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525169Z.525169: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525216Z.525216: gabble_connection_refresh_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:2544): not emitting self-presence stanza: not connected yet
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525251Z.525251: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x12890c0 for localhost
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.525330Z.525330: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='localhost' id='525059525297'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.525384Z.525384: Writing xml: <iq type="get" to="localhost" id="525059525297"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.525445Z.525445: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x1288f80 for test@localhost
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.525604Z.525604: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='test@localhost' id='524297525494'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.525650Z.525650: Writing xml: <iq type="get" to="test@localhost" id="524297525494"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.526574Z.526574: Parsing chunk: <iq to='localhost' type='result' id='525059525297' from='localhost'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.526659Z.526659: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='localhost' type='result' id='525059525297' from='localhost'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.526715Z.526715: connection_disco_cb: got:
* query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.526746Z.526746: connection_disco_cb (/home/smcv/src/fdo/gabble/src/connection.c:2905): set features flags to 0
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.526811Z.526811: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='526601526789'
    * query xmlns='jabber:iq:privacy'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.526846Z.526846: Writing xml: <iq type="get" id="526601526789"><query xmlns="jabber:iq:privacy"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.527602Z.527602: Parsing chunk: <iq to='test@localhost' type='result' id='524297525494' from='test@localhost'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.527698Z.527698: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost' type='result' id='524297525494' from='test@localhost'
    * query xmlns='http://jabber.org/protocol/disco#info'
        * identity category='pubsub' type='pep'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.527759Z.527759: bare_jid_disco_cb (/home/smcv/src/fdo/gabble/src/connection.c:1809): Server advertises PEP support in our jid features
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.528485Z.528485: Parsing chunk: <iq type='error' id='526601526789'><query xmlns='jabber:iq:privacy'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.528563Z.528563: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='error' id='526601526789'
    * query xmlns='jabber:iq:privacy'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.528616Z.528616: get_existing_privacy_lists_cb (/home/smcv/src/fdo/gabble/src/conn-presence.c:1095): Error getting privacy lists: stanza had type='error' but no <error/> node
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.528761Z.528761: gabble_presence_cache_add_own_caps (/home/smcv/src/fdo/gabble/src/presence-cache.c:2207): caching our own caps (http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.528826Z.528826: _write_node_tree: Serializing tree:
* presence xmlns='jabber:client'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.528869Z.528869: Writing xml: <presence><x xmlns="vcard-temp:x:update"/><c hash="sha-1" node="http://telepathy.freedesktop.org/caps" ver="OQIfnSbXxX7Q3RvynKhgLP/6P/A=" ext="pmuc-v1" xmlns="http://jabber.org/protocol/caps"/></presence>
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.529006Z.529006: tp_base_connection_change_status: was 1, now 0, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.529035Z.529035: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529080Z.529080: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/roster.c:1804): requesting roster
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.529148Z.529148: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='524810529125'
    * query xmlns='jabber:iq:roster'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.529183Z.529183: Writing xml: <iq type="get" id="524810529125"><query xmlns="jabber:iq:roster"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529237Z.529237: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529280Z.529280: gabble_jingle_info_take_stun_server (/home/smcv/src/fdo/gabble/src/jingle-info.c:321): Resolving fallback STUN server stun.telepathy.im:3478
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529354Z.529354: gabble_disco_conn_status_changed_cb (/home/smcv/src/fdo/gabble/src/disco.c:902): connected, initiating service discovery on localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529389Z.529389: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x1288dc0 for localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529475Z.529475: gabble_vcard_manager_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1594): Created request 0x12c8550 to retrieve <1>'s vCard
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529516Z.529516: request_send (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1528): Cache entry 0x1288e40 is my own, not setting @to
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529563Z.529563: gabble_request_pipeline_enqueue (/home/smcv/src/fdo/gabble/src/request-pipeline.c:431): enqueued new request as item 0x12c8150
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529594Z.529594: gabble_request_pipeline_enqueue (/home/smcv/src/fdo/gabble/src/request-pipeline.c:432): number of items in flight: 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529626Z.529626: request_send (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1549): adding request to cache entry 0x1288e40 and queueing the <iq>
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.529697Z.529697: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.529732Z.529732: construct_simple_presence_hash: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.529950Z.529950: sidecars_conn_status_changed_cb (/home/smcv/src/fdo/gabble/src/conn-sidecars.c:322): connected; requesting sidecars from plugins
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530076Z.530076: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='localhost' id='524302529432'
    * query xmlns='http://jabber.org/protocol/disco#items'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530116Z.530116: Writing xml: <iq type="get" to="localhost" id="524302529432"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.530189Z.530189: stun_server_resolved_cb (/home/smcv/src/fdo/gabble/src/jingle-info.c:272): Resolved STUN server stun.telepathy.im:3478 to 6.7.8.9:3478
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530379Z.530379: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='524565529886'
    * pubsub xmlns='http://jabber.org/protocol/pubsub'
        * publish node='http://laptop.org/xmpp/activities'
            * item
                * activities xmlns='http://laptop.org/xmpp/activities'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530447Z.530447: Writing xml: <iq type="set" id="524565529886"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="http://laptop.org/xmpp/activities"><item><activities xmlns="http://laptop.org/xmpp/activities"/></item></publish></pubsub></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530541Z.530541: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='524811529923'
    * pubsub xmlns='http://jabber.org/protocol/pubsub'
        * publish node='http://laptop.org/xmpp/activity-properties'
            * item
                * activities xmlns='http://laptop.org/xmpp/activity-properties'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.530851Z.530851: Writing xml: <iq type="set" id="524811529923"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="http://laptop.org/xmpp/activity-properties"><item><activities xmlns="http://laptop.org/xmpp/activity-properties"/></item></publish></pubsub></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.530952Z.530952: gabble_request_pipeline_go (/home/smcv/src/fdo/gabble/src/request-pipeline.c:388): called; 1 pending items, 0 items in flight
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.530985Z.530985: send_next_request (/home/smcv/src/fdo/gabble/src/request-pipeline.c:359): processing request 0x12c8150
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.531036Z.531036: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='526860531011'
    * vCard xmlns='vcard-temp'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.531071Z.531071: Writing xml: <iq type="get" id="526860531011"><vCard xmlns="vcard-temp"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.531136Z.531136: Parsing chunk: <iq from='fake_contact@jabber.org/resource' type='get' id='H_3'><query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='/></iq><presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.531249Z.531249: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='fake_contact@jabber.org/resource' type='get' id='H_3'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.534067Z.534067: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.534408Z.534408: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' to='fake_contact@jabber.org/resource' id='H_3'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='
        * identity category='client' name='Telepathy Gabble 0.16.999.1' type='pc'
        * feature var='http://www.google.com/xmpp/protocol/session'
        * feature var='urn:xmpp:jingle:transports:raw-udp:1'
        * feature var='http://jabber.org/protocol/jingle'
        * feature var='urn:xmpp:jingle:1'
        * feature var='http://jabber.org/protocol/chatstates'
        * feature var='http://jabber.org/protocol/nick'
        * feature var='http://jabber.org/protocol/nick+notify'
        * feature var='http://jabber.org/protocol/si'
        * feature var='http://jabber.org/protocol/ibb'
        * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
        * feature var='http://jabber.org/protocol/bytestreams'
        * feature var='jabber:iq:version'
        * feature var='http://www.google.com/transport/p2p'
        * feature var='urn:xmpp:jingle:transports:ice-udp:1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.534518Z.534518: Writing xml: <iq type="result" to="fake_contact@jabber.org/resource" id="H_3"><query node="http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" name="Telepathy Gabble 0.16.999.1" type="pc"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/></query></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.534670Z.534670: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (1) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.534840Z.534840: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.535196Z.535196: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.535227Z.535227: construct_simple_presence_hash: called.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.537654Z.537654: caps_cache_get_one_uint: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:524: 'PRAGMA table_info(capabilities)' returned no results
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.537725Z.537725: caps_cache_check_version: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:240: opened new, empty database at :memory:
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.539063Z.539063: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:605: caps cache miss: http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539205Z.539205: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=, setting caps for 1 (test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539249Z.539249: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539282Z.539282: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539313Z.539313: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 1, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539363Z.539363: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.539461Z.539461: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 1
  --added--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  --end--
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.540551Z.540551: Parsing chunk: <iq type='result' id='524810529125'><query xmlns='jabber:iq:roster'><item jid='test1@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.540708Z.540708: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='524810529125'
    * query xmlns='jabber:iq:roster'
        * item jid='test1@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.540785Z.540785: validate_roster_item: item node has resource in jid, skipping:
* item xmlns='jabber:iq:roster' jid='test1@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.540863Z.540863: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.540887Z.540887: construct_simple_presence_hash: called.
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES|MEMBERS_CHANGED_DETAILED]
(telepathy-gabble:19315): tp-glib/contact-lists-DEBUG: 2012-05-07T17:49:03.541945Z.541945: tp_base_contact_list_set_list_received: Initial contacts: 
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542040Z.542040: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542115Z.542115: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542175Z.542175: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542233Z.542233: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542292Z.542292: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.542363Z.542363: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544558Z.544558: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3386): enter
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544613Z.544613: gabble_media_factory_add_caps (/home/smcv/src/fdo/gabble/src/media-factory.c:1023): Client self media capabilities:
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544646Z.544646: gabble_ft_manager_represent_client (/home/smcv/src/fdo/gabble/src/ft-manager.c:1060): client self supports file transfer
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544690Z.544690: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3447): client self contributes:
  --begin--
  Feature: http://jabber.org/protocol/si/profile/file-transfer
  Feature: http://telepathy.freedesktop.org/xmpp/file-transfer-metadata
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--

(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544727Z.544727: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3478): client self has no interesting data forms
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544779Z.544779: gabble_connection_refresh_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:2512): incorporating caps for self:
  --begin--
  Feature: http://jabber.org/protocol/si/profile/file-transfer
  Feature: http://telepathy.freedesktop.org/xmpp/file-transfer-metadata
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--

(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544819Z.544819: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource Resource with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544845Z.544845: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544871Z.544871: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 2, old 1, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544901Z.544901: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.544987Z.544987: gabble_presence_cache_add_own_caps (/home/smcv/src/fdo/gabble/src/presence-cache.c:2207): caching our own caps (http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4=)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.545040Z.545040: _write_node_tree: Serializing tree:
* presence xmlns='jabber:client'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='teBeeyUv+W1H3LJ2H2Qw/IOg8d4=' ext='pmuc-v1 share-v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.545081Z.545081: Writing xml: <presence><x xmlns="vcard-temp:x:update"/><c hash="sha-1" node="http://telepathy.freedesktop.org/caps" ver="teBeeyUv+W1H3LJ2H2Qw/IOg8d4=" ext="pmuc-v1 share-v1" xmlns="http://jabber.org/protocol/caps"/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.578118Z.578118: Parsing chunk: <presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.578274Z.578274: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578398Z.578398: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (1) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578465Z.578465: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.578594Z.578594: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:605: caps cache miss: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578637Z.578637: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1591): not enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578672Z.578672: disco_waiter_new (/home/smcv/src/fdo/gabble/src/presence-cache.c:161): created waiter 0x12cecf0 for handle 1 with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578705Z.578705: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1636): only 0 trust out of 5 possible thus far, sending disco for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578740Z.578740: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x1289000 for test@localhost/jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.578830Z.578830: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='524307578793'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.578877Z.578877: Writing xml: <iq type="get" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="524307578793"><query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.578944Z.578944: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.580085Z.580085: Parsing chunk: <iq to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='get' id='524307578793' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4='/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.580175Z.580175: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='get' id='524307578793' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4='
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.580362Z.580362: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='524307578793'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4='
        * identity category='client' name='Telepathy Gabble 0.16.999.1' type='pc'
        * feature var='http://www.google.com/xmpp/protocol/session'
        * feature var='urn:xmpp:jingle:transports:raw-udp:1'
        * feature var='http://jabber.org/protocol/jingle'
        * feature var='urn:xmpp:jingle:1'
        * feature var='http://jabber.org/protocol/chatstates'
        * feature var='http://jabber.org/protocol/nick'
        * feature var='http://jabber.org/protocol/nick+notify'
        * feature var='http://jabber.org/protocol/si'
        * feature var='http://jabber.org/protocol/ibb'
        * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
        * feature var='http://jabber.org/protocol/bytestreams'
        * feature var='jabber:iq:version'
        * feature var='http://jabber.org/protocol/si/profile/file-transfer'
        * feature var='http://telepathy.freedesktop.org/xmpp/file-transfer-metadata'
        * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.580478Z.580478: Writing xml: <iq type="result" from="test@localhost/jingle-share/test-send-file-send-before-accept.py" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="524307578793"><query node="http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" name="Telepathy Gabble 0.16.999.1" type="pc"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://jabber.org/protocol/si/profile/file-transfer"/><feature var="http://telepathy.freedesktop.org/xmpp/file-transfer-metadata"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.582480Z.582480: Parsing chunk: <iq from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524307578793' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'><query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='><identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'/><feature var='http://www.google.com/xmpp/protocol/session'/><feature var='urn:xmpp:jingle:transports:raw-udp:1'/><feature var='http://jabber.org/protocol/jingle'/><feature var='urn:xmpp:jingle:1'/><feature var='http://jabber.org/protocol/chatstates'/><feature var='http://jabber.org/protocol/nick'/><feature var='http://jabber.org/protocol/nick+notify'/><feature var='http://jabber.org/protocol/si'/><feature var='http://jabber.org/protocol/ibb'/><feature var='http://telepathy.freedesktop.org/xmpp/tubes'/><feature var='http://jabber.org/protocol/bytestreams'/><feature var='jabber:iq:version'/><feature var='http://www.google.com/transport/p2p
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.582649Z.582649: Parsing chunk: '/><feature var='urn:xmpp:jingle:transports:ice-udp:1'/><feature var='http://google.com/xmpp/protocol/share/v1'/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.582748Z.582748: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524307578793' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
        * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
        * feature var='http://www.google.com/xmpp/protocol/session'
        * feature var='urn:xmpp:jingle:transports:raw-udp:1'
        * feature var='http://jabber.org/protocol/jingle'
        * feature var='urn:xmpp:jingle:1'
        * feature var='http://jabber.org/protocol/chatstates'
        * feature var='http://jabber.org/protocol/nick'
        * feature var='http://jabber.org/protocol/nick+notify'
        * feature var='http://jabber.org/protocol/si'
        * feature var='http://jabber.org/protocol/ibb'
        * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
        * feature var='http://jabber.org/protocol/bytestreams'
        * feature var='jabber:iq:version'
        * feature var='http://www.google.com/transport/p2p'
        * feature var='urn:xmpp:jingle:transports:ice-udp:1'
        * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.582892Z.582892: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 1: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583052Z.583052: _caps_disco_cb (/home/smcv/src/fdo/gabble/src/presence-cache.c:1422): trusting http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY= to mean:
  --begin--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.583143Z.583143: wocky_caps_cache_insert: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:798: caps cache insert: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.583267Z.583267: _write_node_tree: Serializing tree:
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.583374Z.583374: Writing xml: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583555Z.583555: set_caps_for (/home/smcv/src/fdo/gabble/src/presence-cache.c:1184): setting caps for 1 (thanks to 1 test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583598Z.583598: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583630Z.583630: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583660Z.583660: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 2, old 1, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583693Z.583693: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.583748Z.583748: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 1
  --added--
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.584175Z.584175: disco_waiter_list_free (/home/smcv/src/fdo/gabble/src/presence-cache.c:187): list 0x12c7e30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.584214Z.584214: disco_waiter_free (/home/smcv/src/fdo/gabble/src/presence-cache.c:172): freeing waiter 0x12cecf0 for handle 1 with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.590970Z.590970: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2205): disabling SRV because "server" or "old-ssl" was specified or port was not 5222, will connect to localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.591022Z.591022: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2224): require-encryption is False; flipping ignore_ssl_errors to True
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.591076Z.591076: _gabble_connection_connect (/home/smcv/src/fdo/gabble/src/connection.c:2264): Start connecting
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.591134Z.591134: connector_connect_async: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:2314: host: localhost; port: 4242
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.591251Z.591251: tp_base_connection_change_status: was 4294967295, now 1, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.591277Z.591277: tp_base_connection_change_status: emitting status-changed to 1, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.591315Z.591315: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213d80:item-found with context 0x12fbc40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.591347Z.591347: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1213d80:done with context 0x12f5c80
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.591380Z.591380: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.591725Z.591725: tcp_host_connected: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:937: HOST connection succeeded
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.591826Z.591826: xmpp_init: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1056: sending XMPP stream open to server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.591867Z.591867: wocky_xmpp_writer_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:298: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="localhost" version="1.0">

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.591981Z.591981: xmpp_init_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1077: waiting for stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.592968Z.592968: Parsing chunk: <stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' version='1.0' id='1ce1b924bbe7ab53'><stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>PLAIN</mechanism></mechanisms></stream:features>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593019Z.593019: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:431: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593050Z.593050: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593078Z.593078: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: id = '1ce1b924bbe7ab53' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593142Z.593142: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'
        * mechanism
            "PLAIN"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593182Z.593182: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1111: TCP Connection Established: : received XMPP version=1.0 stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593214Z.593214: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1126: waiting for feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593272Z.593272: xmpp_features_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1182: received feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593327Z.593327: sasl_request_auth: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1310: handing over control to SASL module
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593362Z.593362: wocky_auth_registry_select_handler: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-auth-registry.c:287: Choosing PLAIN as auth mechanism
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593407Z.593407: plain_initial_response: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-sasl-plain.c:165: Got username and password
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593485Z.593485: _write_node_tree: Serializing tree:
* auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' xmlns:wocky-zb='http://www.google.com/talk/protocol/auth' wocky-zb:client-uses-full-bind-result='true' mechanism='PLAIN'
    "AHRlc3QxAHBhc3M="
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593529Z.593529: Writing xml: <auth wocky-zb:client-uses-full-bind-result="true" mechanism="PLAIN" xmlns:wocky-zb="http://www.google.com/talk/protocol/auth" xmlns="urn:ietf:params:xml:ns:xmpp-sasl">AHRlc3QxAHBhc3M=</auth>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.593966Z.593966: Parsing chunk: <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594036Z.594036: _end_element_ns: Received stanza
* success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594101Z.594101: auth_succeeded: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-sasl-auth.c:245: Authentication succeeded
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594133Z.594133: sasl_auth_done: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1345: SASL complete (success)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594161Z.594161: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594198Z.594198: xmpp_init: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1056: sending XMPP stream open to server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594231Z.594231: wocky_xmpp_writer_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:298: Writing stream opening: <?xml version='1.0' encoding='UTF-8'?>
<stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' to="localhost" version="1.0">

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.594322Z.594322: xmpp_init_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1077: waiting for stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.599993Z.599993: Parsing chunk: <stream:stream xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' version='1.0' id='1cae0786f87e9f96'><stream:features><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></stream:features>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600054Z.600054: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:431: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600088Z.600088: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: version = '1.0' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600117Z.600117: handle_stream_open: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:450: Stream opening attribute: id = '1cae0786f87e9f96' (prefix: <no prefix>, uri: <no uri>)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600185Z.600185: _end_element_ns: Received stanza
* features xmlns='http://etherx.jabber.org/streams'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600227Z.600227: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1111: Authentication Completed: : received XMPP version=1.0 stream open from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600259Z.600259: xmpp_init_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1126: waiting for feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600319Z.600319: xmpp_features_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1182: received feature stanza from server
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600377Z.600377: iq_bind_resource: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1845: sending bind iq set stanza
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600419Z.600419: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='526593600353'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
        * resource
            "Resource"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600459Z.600459: Writing xml: <iq type="set" id="526593600353"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource>Resource</resource></bind></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.600568Z.600568: iq_bind_resource_sent_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1868: bind iq set stanza sent
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.603219Z.603219: Parsing chunk: <iq type='result' id='526593600353'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>test1@localhost/Resource</jid></bind></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.603312Z.603312: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='526593600353'
    * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'
        * jid
            "test1@localhost/Resource"
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.603357Z.603357: iq_bind_resource_recv_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-connector.c:1886: bind iq response stanza received
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.603421Z.603421: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='524301603388'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.603460Z.603460: Writing xml: <iq type="set" id="524301603388"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.604680Z.604680: Parsing chunk: <iq type='result' id='524301603388'><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.604753Z.604753: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='524301603388'
    * session xmlns='urn:ietf:params:xml:ns:xmpp-session'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.604809Z.604809: connector_connected (/home/smcv/src/fdo/gabble/src/connection.c:1931): connected (jid: test1@localhost/Resource)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.604926Z.604926: wocky_ping_set_property: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-ping.c:87: updated ping interval to 30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.605014Z.605014: gabble_roster_porter_available_cb (/home/smcv/src/fdo/gabble/src/roster.c:1768): adding callbacks
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.605081Z.605081: porter_available_cb (/home/smcv/src/fdo/gabble/src/im-factory.c:515): adding callbacks
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.605245Z.605245: test_channel_manager_porter_available_cb: now we have a porter: 0x12c1970
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.605553Z.605553: connector_connected (/home/smcv/src/fdo/gabble/src/connection.c:1996): Created self handle 1, our JID is test1@localhost/Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.605631Z.605631: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource Resource with serial 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.605970Z.605970: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.606001Z.606001: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 1, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.606034Z.606034: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.606090Z.606090: gabble_connection_refresh_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:2544): not emitting self-presence stanza: not connected yet
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.606130Z.606130: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x1289000 for localhost
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.606205Z.606205: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='localhost' id='527106606176'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.606267Z.606267: Writing xml: <iq type="get" to="localhost" id="527106606176"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.606322Z.606322: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x1288f40 for test1@localhost
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.606484Z.606484: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='test1@localhost' id='524305606366'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.606530Z.606530: Writing xml: <iq type="get" to="test1@localhost" id="524305606366"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.607335Z.607335: Parsing chunk: <iq to='localhost' type='result' id='527106606176' from='localhost'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.607409Z.607409: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='localhost' type='result' id='527106606176' from='localhost'
    * query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.607465Z.607465: connection_disco_cb: got:
* query xmlns='http://jabber.org/protocol/disco#info'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.607496Z.607496: connection_disco_cb (/home/smcv/src/fdo/gabble/src/connection.c:2905): set features flags to 0
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.607561Z.607561: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='524551607539'
    * query xmlns='jabber:iq:privacy'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.607597Z.607597: Writing xml: <iq type="get" id="524551607539"><query xmlns="jabber:iq:privacy"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.608288Z.608288: Parsing chunk: <iq to='test1@localhost' type='result' id='524305606366' from='test1@localhost'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='pubsub' type='pep'/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.608370Z.608370: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test1@localhost' type='result' id='524305606366' from='test1@localhost'
    * query xmlns='http://jabber.org/protocol/disco#info'
        * identity category='pubsub' type='pep'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.608426Z.608426: bare_jid_disco_cb (/home/smcv/src/fdo/gabble/src/connection.c:1809): Server advertises PEP support in our jid features
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609135Z.609135: Parsing chunk: <iq type='error' id='524551607539'><query xmlns='jabber:iq:privacy'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609200Z.609200: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='error' id='524551607539'
    * query xmlns='jabber:iq:privacy'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609248Z.609248: get_existing_privacy_lists_cb (/home/smcv/src/fdo/gabble/src/conn-presence.c:1095): Error getting privacy lists: stanza had type='error' but no <error/> node
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609375Z.609375: gabble_presence_cache_add_own_caps (/home/smcv/src/fdo/gabble/src/presence-cache.c:2207): caching our own caps (http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609434Z.609434: _write_node_tree: Serializing tree:
* presence xmlns='jabber:client'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609493Z.609493: Writing xml: <presence><x xmlns="vcard-temp:x:update"/><c hash="sha-1" node="http://telepathy.freedesktop.org/caps" ver="OQIfnSbXxX7Q3RvynKhgLP/6P/A=" ext="pmuc-v1" xmlns="http://jabber.org/protocol/caps"/></presence>
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.609612Z.609612: tp_base_connection_change_status: was 1, now 0, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.609641Z.609641: tp_base_connection_change_status: emitting status-changed to 0, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609682Z.609682: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/roster.c:1804): requesting roster
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609749Z.609749: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='526612609727'
    * query xmlns='jabber:iq:roster'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.609785Z.609785: Writing xml: <iq type="get" id="526612609727"><query xmlns="jabber:iq:roster"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609849Z.609849: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609892Z.609892: gabble_jingle_info_take_stun_server (/home/smcv/src/fdo/gabble/src/jingle-info.c:321): Resolving fallback STUN server stun.telepathy.im:3478
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.609971Z.609971: gabble_disco_conn_status_changed_cb (/home/smcv/src/fdo/gabble/src/disco.c:902): connected, initiating service discovery on localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610006Z.610006: gabble_disco_request_with_timeout (/home/smcv/src/fdo/gabble/src/disco.c:498): Creating disco request 0x12b9780 for localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610094Z.610094: gabble_vcard_manager_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1594): Created request 0x130f090 to retrieve <1>'s vCard
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610130Z.610130: request_send (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1528): Cache entry 0x1311440 is my own, not setting @to
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610177Z.610177: gabble_request_pipeline_enqueue (/home/smcv/src/fdo/gabble/src/request-pipeline.c:431): enqueued new request as item 0x130ed50
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610207Z.610207: gabble_request_pipeline_enqueue (/home/smcv/src/fdo/gabble/src/request-pipeline.c:432): number of items in flight: 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610240Z.610240: request_send (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1549): adding request to cache entry 0x1311440 and queueing the <iq>
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.610287Z.610287: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.610314Z.610314: construct_simple_presence_hash: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610510Z.610510: sidecars_conn_status_changed_cb (/home/smcv/src/fdo/gabble/src/conn-sidecars.c:322): connected; requesting sidecars from plugins
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.610650Z.610650: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' to='localhost' id='527118610056'
    * query xmlns='http://jabber.org/protocol/disco#items'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.610691Z.610691: Writing xml: <iq type="get" to="localhost" id="527118610056"><query xmlns="http://jabber.org/protocol/disco#items"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.610760Z.610760: stun_server_resolved_cb (/home/smcv/src/fdo/gabble/src/jingle-info.c:272): Resolved STUN server stun.telepathy.im:3478 to 6.7.8.9:3478
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.610851Z.610851: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='524307610444'
    * pubsub xmlns='http://jabber.org/protocol/pubsub'
        * publish node='http://laptop.org/xmpp/activities'
            * item
                * activities xmlns='http://laptop.org/xmpp/activities'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.610899Z.610899: Writing xml: <iq type="set" id="524307610444"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="http://laptop.org/xmpp/activities"><item><activities xmlns="http://laptop.org/xmpp/activities"/></item></publish></pubsub></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.610994Z.610994: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' id='524296610480'
    * pubsub xmlns='http://jabber.org/protocol/pubsub'
        * publish node='http://laptop.org/xmpp/activity-properties'
            * item
                * activities xmlns='http://laptop.org/xmpp/activity-properties'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611046Z.611046: Writing xml: <iq type="set" id="524296610480"><pubsub xmlns="http://jabber.org/protocol/pubsub"><publish node="http://laptop.org/xmpp/activity-properties"><item><activities xmlns="http://laptop.org/xmpp/activity-properties"/></item></publish></pubsub></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.611152Z.611152: gabble_request_pipeline_go (/home/smcv/src/fdo/gabble/src/request-pipeline.c:388): called; 1 pending items, 0 items in flight
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.611202Z.611202: send_next_request (/home/smcv/src/fdo/gabble/src/request-pipeline.c:359): processing request 0x130ed50
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611252Z.611252: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='get' id='525078611229'
    * vCard xmlns='vcard-temp'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611286Z.611286: Writing xml: <iq type="get" id="525078611229"><vCard xmlns="vcard-temp"/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611482Z.611482: Parsing chunk: <iq from='fake_contact@jabber.org/resource' type='get' id='H_8'><query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='/></iq><presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence><presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611582Z.611582: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='fake_contact@jabber.org/resource' type='get' id='H_8'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611666Z.611666: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611751Z.611751: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.611932Z.611932: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' to='fake_contact@jabber.org/resource' id='H_8'
    * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A='
        * identity category='client' name='Telepathy Gabble 0.16.999.1' type='pc'
        * feature var='http://www.google.com/xmpp/protocol/session'
        * feature var='urn:xmpp:jingle:transports:raw-udp:1'
        * feature var='http://jabber.org/protocol/jingle'
        * feature var='urn:xmpp:jingle:1'
        * feature var='http://jabber.org/protocol/chatstates'
        * feature var='http://jabber.org/protocol/nick'
        * feature var='http://jabber.org/protocol/nick+notify'
        * feature var='http://jabber.org/protocol/si'
        * feature var='http://jabber.org/protocol/ibb'
        * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
        * feature var='http://jabber.org/protocol/bytestreams'
        * feature var='jabber:iq:version'
        * feature var='http://www.google.com/transport/p2p'
        * feature var='urn:xmpp:jingle:transports:ice-udp:1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.612021Z.612021: Writing xml: <iq type="result" to="fake_contact@jabber.org/resource" id="H_8"><query node="http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" name="Telepathy Gabble 0.16.999.1" type="pc"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/></query></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.612197Z.612197: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.612261Z.612261: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.612304Z.612304: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.612332Z.612332: construct_simple_presence_hash: called.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.612525Z.612525: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.612567Z.612567: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.612830Z.612830: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.612967Z.612967: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613033Z.613033: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 2 (test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613072Z.613072: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613104Z.613104: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613135Z.613135: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 1, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613167Z.613167: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613215Z.613215: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 2: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613323Z.613323: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 2
  --added--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613795Z.613795: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test1@localhost (1) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.613858Z.613858: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.613898Z.613898: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.613925Z.613925: construct_simple_presence_hash: called.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.614066Z.614066: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:605: caps cache miss: http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614110Z.614110: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=, setting caps for 1 (test1@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614147Z.614147: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614178Z.614178: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614209Z.614209: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 2, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614241Z.614241: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.614320Z.614320: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 1
  --added--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  --end--
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.617031Z.617031: Parsing chunk: <iq type='result' id='526612609727'><query xmlns='jabber:iq:roster'><item jid='test@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'/></query></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.617116Z.617116: _end_element_ns: Received stanza
* iq xmlns='jabber:client' type='result' id='526612609727'
    * query xmlns='jabber:iq:roster'
        * item jid='test@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.617182Z.617182: validate_roster_item: item node has resource in jid, skipping:
* item xmlns='jabber:iq:roster' jid='test@localhost/jingle-share/test-send-file-send-before-accept.py' subscription='both'
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.617234Z.617234: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.617260Z.617260: construct_simple_presence_hash: called.
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|CAN_RESCIND|MESSAGE_ADD|PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [PROPERTIES]
  removed  : []
  flags now: [PROPERTIES|MEMBERS_CHANGED_DETAILED]
tp_group_mixin_change_flags: emitting group flags changed
  added    : [CAN_ADD|CAN_REMOVE]
  removed  : []
  flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES|MEMBERS_CHANGED_DETAILED]
(telepathy-gabble:19315): tp-glib/contact-lists-DEBUG: 2012-05-07T17:49:03.618232Z.618232: tp_base_contact_list_set_list_received: Initial contacts: 
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618320Z.618320: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618394Z.618394: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618471Z.618471: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618539Z.618539: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618607Z.618607: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): tp-glib/groups-DEBUG: 2012-05-07T17:49:03.618672Z.618672: change_members: not emitting signal, nothing changed
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.620102Z.620102: Parsing chunk: <presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.620202Z.620202: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='OQIfnSbXxX7Q3RvynKhgLP/6P/A=' ext='pmuc-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620281Z.620281: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test1@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620339Z.620339: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.620380Z.620380: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:03.620406Z.620406: construct_simple_presence_hash: called.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.620600Z.620600: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:605: caps cache miss: http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620673Z.620673: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#OQIfnSbXxX7Q3RvynKhgLP/6P/A=, setting caps for 2 (test1@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620711Z.620711: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620743Z.620743: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620773Z.620773: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 3, old 0, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620805Z.620805: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.620884Z.620884: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 2
  --added--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  --end--
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636220Z.636220: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3386): enter
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636285Z.636285: gabble_media_factory_add_caps (/home/smcv/src/fdo/gabble/src/media-factory.c:1023): Client self media capabilities:
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636321Z.636321: gabble_ft_manager_represent_client (/home/smcv/src/fdo/gabble/src/ft-manager.c:1060): client self supports file transfer
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636370Z.636370: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3447): client self contributes:
  --begin--
  Feature: http://jabber.org/protocol/si/profile/file-transfer
  Feature: http://telepathy.freedesktop.org/xmpp/file-transfer-metadata
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--

(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636408Z.636408: gabble_connection_update_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:3478): client self has no interesting data forms
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636470Z.636470: gabble_connection_refresh_capabilities (/home/smcv/src/fdo/gabble/src/connection.c:2512): incorporating caps for self:
  --begin--
  Feature: http://jabber.org/protocol/si/profile/file-transfer
  Feature: http://telepathy.freedesktop.org/xmpp/file-transfer-metadata
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--

(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636518Z.636518: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource Resource with serial 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636549Z.636549: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636596Z.636596: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 2, old 1, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636631Z.636631: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource Resource
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.636735Z.636735: gabble_presence_cache_add_own_caps (/home/smcv/src/fdo/gabble/src/presence-cache.c:2207): caching our own caps (http://telepathy.freedesktop.org/caps#teBeeyUv+W1H3LJ2H2Qw/IOg8d4=)
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.636799Z.636799: _write_node_tree: Serializing tree:
* presence xmlns='jabber:client'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='teBeeyUv+W1H3LJ2H2Qw/IOg8d4=' ext='pmuc-v1 share-v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.636849Z.636849: Writing xml: <presence><x xmlns="vcard-temp:x:update"/><c hash="sha-1" node="http://telepathy.freedesktop.org/caps" ver="teBeeyUv+W1H3LJ2H2Qw/IOg8d4=" ext="pmuc-v1 share-v1" xmlns="http://jabber.org/protocol/caps"/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.656276Z.656276: Parsing chunk: <presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.656397Z.656397: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.656487Z.656487: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test1@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.656545Z.656545: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.656670Z.656670: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.656706Z.656706: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.656914Z.656914: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.657046Z.657046: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657117Z.657117: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 2 (test1@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657157Z.657157: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657189Z.657189: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657223Z.657223: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 4, old 3, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657258Z.657258: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657308Z.657308: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 2: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.657393Z.657393: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 2
  --added--
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.657908Z.657908: Parsing chunk: <presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence><presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658012Z.658012: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658113Z.658113: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658187Z.658187: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658241Z.658241: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658323Z.658323: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658358Z.658358: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658544Z.658544: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.658663Z.658663: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658721Z.658721: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 2 (test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658776Z.658776: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658808Z.658808: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658837Z.658837: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 3, old 1, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658870Z.658870: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658917Z.658917: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 2: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.658985Z.658985: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659090Z.659090: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test1@localhost (1) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659143Z.659143: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.659241Z.659241: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.659276Z.659276: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.659452Z.659452: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.659586Z.659586: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659647Z.659647: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 1 (test1@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659687Z.659687: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659720Z.659720: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659750Z.659750: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 4, old 2, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659784Z.659784: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659830Z.659830: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 1: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.659913Z.659913: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 1
  --added--
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.672885Z.672885: channel_request_new: New channel request at 0x1326530: ctype=org.freedesktop.Telepathy.Channel.Type.FileTransfer htype=1 handle=2 suppress=1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.672949Z.672949: gabble_ft_manager_handle_request (/home/smcv/src/fdo/gabble/src/ft-manager.c:473): File transfer request
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.672992Z.672992: gabble_ft_manager_handle_request (/home/smcv/src/fdo/gabble/src/ft-manager.c:589): Requested outgoing channel with contact: test1@localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673316Z.673316: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x125f000:presences-updated with context 0x132a500
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673360Z.673360: gabble_file_transfer_channel_constructed (/home/smcv/src/fdo/gabble/src/ft-channel.c:451): New FT channel created: /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/FileTransferChannel/0x122c180 (contact: test1@localhost, initiator: test@localhost, file: "The foo.txt", size: 16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673420Z.673420: offer_gtalk_file_transfer (/home/smcv/src/fdo/gabble/src/ft-channel.c:1355): Offering Gtalk file transfer to test1@localhost/jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673461Z.673461: gtalk_file_collection_init (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:214): GTalk file collection init called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673691Z.673691: gabble_jingle_session_init (/home/smcv/src/fdo/gabble/src/jingle-session.c:194): Initializing the jingle session 0x121ae30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673770Z.673770: create_session (/home/smcv/src/fdo/gabble/src/jingle-factory.c:518): new session (test1@localhost/jingle-share/test-send-file-send-before-accept.py, 2141358697) @ 0x121ae30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673834Z.673834: create_content (/home/smcv/src/fdo/gabble/src/jingle-session.c:850): session creating new content name share, type 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673915Z.673915: gabble_jingle_content_init (/home/smcv/src/fdo/gabble/src/jingle-content.c:111): 0x1257980
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.673953Z.673953: gabble_jingle_share_init (/home/smcv/src/fdo/gabble/src/jingle-share.c:155): jingle share init called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674046Z.674046: create_content (/home/smcv/src/fdo/gabble/src/jingle-session.c:888): inserting content share into initiator_contents
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674086Z.674086: _gabble_jingle_content_set_media_ready (/home/smcv/src/fdo/gabble/src/jingle-content.c:1088): media ready on content: share created_by_us: 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674116Z.674116: content_ready_cb (/home/smcv/src/fdo/gabble/src/jingle-session.c:2350): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674142Z.674142: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1945): Trying initiate or accept
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674168Z.674168: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1961): session not locally accepted yet, not initiating
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674200Z.674200: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x121ae30:notify::state with context 0x1325ea0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674232Z.674232: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x121ae30:terminated with context 0x13297a0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674262Z.674262: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257980:new-share-channel with context 0x132a440
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674302Z.674302: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257980:completed with context 0x1325e00
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674334Z.674334: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1945): Trying initiate or accept
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.674444Z.674444: _write_node_tree: Serializing tree:
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='teBeeyUv+W1H3LJ2H2Qw/IOg8d4=' ext='pmuc-v1 share-v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.674495Z.674495: Writing xml: <presence to="test1@localhost/jingle-share/test-send-file-send-before-accept.py"><x xmlns="vcard-temp:x:update"/><c hash="sha-1" node="http://telepathy.freedesktop.org/caps" ver="teBeeyUv+W1H3LJ2H2Qw/IOg8d4=" ext="pmuc-v1 share-v1" xmlns="http://jabber.org/protocol/caps"/></presence>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674546Z.674546: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1992): Contents are ready: yes
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674595Z.674595: produce_description (/home/smcv/src/fdo/gabble/src/jingle-share.c:456): produce description called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674711Z.674711: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121ae30 (priv = 0x121ae50) from 0 to 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674748Z.674748: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674789Z.674789: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.674870Z.674870: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x122c180:closed with context 0x1332980
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.674908Z.674908: satisfy_request: completing queued request 0x1326530 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.FileTransfer, handle_type=1, handle=2, suppress_handler=1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:03.675255Z.675255: channel_request_free: Freeing channel request at 0x1326530: ctype=org.freedesktop.Telepathy.Channel.Type.FileTransfer htype=1 handle=2 suppress=1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.676084Z.676084: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='527118674691'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' id='2141358697' type='initiate'
        * description xmlns='http://www.google.com/session/share'
            * manifest
                * file size='16'
                    * name
                        "The foo.txt"
            * protocol
                * http
                    * url name='source-path'
                        "/temporary/8c6b328f-4453-48eb-b623-5663b716c544/"
                    * url name='preview-path'
                        "/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/"
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.676165Z.676165: Writing xml: <iq type="set" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="527118674691"><session initiator="test@localhost/Resource" id="2141358697" type="initiate" xmlns="http://www.google.com/session"><description xmlns="http://www.google.com/session/share"><manifest><file size="16"><name>The foo.txt</name></file></manifest><protocol><http><url name="source-path">/temporary/8c6b328f-4453-48eb-b623-5663b716c544/</url><url name="preview-path">/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/</url></http></protocol></description><transport xmlns="http://www.google.com/transport/p2p"/></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.694449Z.694449: Parsing chunk: <presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence><presence to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.694602Z.694602: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.696222Z.696222: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.696348Z.696348: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (1) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.696416Z.696416: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.696552Z.696552: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.696588Z.696588: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.696808Z.696808: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.696943Z.696943: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697012Z.697012: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 1 (test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697053Z.697053: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 5
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697084Z.697084: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697131Z.697131: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 5, old 2, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697165Z.697165: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697249Z.697249: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 1: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697352Z.697352: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.697505Z.697505: Parsing chunk: <presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><x xmlns='vcard-temp:x:update'/><c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'/></presence><iq to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='527118674691' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='initiate' id='2141358697'><description xmlns='http://www.google.com/session/share'><manifest><file size='16'><name>The foo.txt</name></file></manifest><protocol><http><url name='source-path'>/temporary/8c6b328f-4453-48eb-b623-5663b716c544/</url><url name='preview-path'>/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/</url></http></protocol></description><transport xmlns='http://www.google.com/transpo
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.697614Z.697614: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * x xmlns='vcard-temp:x:update'
    * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='vteXf8yBMY5wRHCMPobHWk6FtJY=' ext='pmuc-v1 share-v1' hash='sha-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697748Z.697748: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.697803Z.697803: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.697888Z.697888: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.697923Z.697923: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.698125Z.698125: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.698250Z.698250: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698310Z.698310: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 2 (test@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698351Z.698351: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 5
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698384Z.698384: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698415Z.698415: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 5, old 3, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698540Z.698540: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698591Z.698591: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 2: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698662Z.698662: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698756Z.698756: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test1@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 7 (available) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.698809Z.698809: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.698890Z.698890: wocky_caps_cache_lookup: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-caps-cache.c:618: caps cache hit: http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.698925Z.698925: Parsing chunk: <?xml version="1.0" encoding="UTF-8"?>
<query node="http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=" xmlns="http://jabber.org/protocol/disco#info"><identity category="client" type="pc" name="Telepathy Gabble 0.16.999.1"/><feature var="http://www.google.com/xmpp/protocol/session"/><feature var="urn:xmpp:jingle:transports:raw-udp:1"/><feature var="http://jabber.org/protocol/jingle"/><feature var="urn:xmpp:jingle:1"/><feature var="http://jabber.org/protocol/chatstates"/><feature var="http://jabber.org/protocol/nick"/><feature var="http://jabber.org/protocol/nick+notify"/><feature var="http://jabber.org/protocol/si"/><feature var="http://jabber.org/protocol/ibb"/><feature var="http://telepathy.freedesktop.org/xmpp/tubes"/><feature var="http://jabber.org/protocol/bytestreams"/><feature var="jabber:iq:version"/><feature var="http://www.google.com/transport/p2p"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="http://google.com/xmpp/protocol/share/v1"/></query>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.699123Z.699123: _end_element_ns: Received stanza
* query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY='
    * identity category='client' type='pc' name='Telepathy Gabble 0.16.999.1'
    * feature var='http://www.google.com/xmpp/protocol/session'
    * feature var='urn:xmpp:jingle:transports:raw-udp:1'
    * feature var='http://jabber.org/protocol/jingle'
    * feature var='urn:xmpp:jingle:1'
    * feature var='http://jabber.org/protocol/chatstates'
    * feature var='http://jabber.org/protocol/nick'
    * feature var='http://jabber.org/protocol/nick+notify'
    * feature var='http://jabber.org/protocol/si'
    * feature var='http://jabber.org/protocol/ibb'
    * feature var='http://telepathy.freedesktop.org/xmpp/tubes'
    * feature var='http://jabber.org/protocol/bytestreams'
    * feature var='jabber:iq:version'
    * feature var='http://www.google.com/transport/p2p'
    * feature var='urn:xmpp:jingle:transports:ice-udp:1'
    * feature var='http://google.com/xmpp/protocol/share/v1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.699277Z.699277: wocky_xmpp_reader_reset: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:775: Resetting the xmpp reader
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699335Z.699335: _process_caps_uri (/home/smcv/src/fdo/gabble/src/presence-cache.c:1552): enough trust for URI http://telepathy.freedesktop.org/caps#vteXf8yBMY5wRHCMPobHWk6FtJY=, setting caps for 2 (test1@localhost/jingle-share/test-send-file-send-before-accept.py)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699375Z.699375: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:335): about to add caps to resource jingle-share/test-send-file-send-before-accept.py with serial 6
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699406Z.699406: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:346): found resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699437Z.699437: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:351): new serial 6, old 4, clearing caps
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699470Z.699470: gabble_presence_set_capabilities (/home/smcv/src/fdo/gabble/src/presence.c:359): updating caps for resource jingle-share/test-send-file-send-before-accept.py
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699517Z.699517: client_types_from_message (/home/smcv/src/fdo/gabble/src/presence-cache.c:1243): Got type for 2: pc (16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699586Z.699586: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1141): no change in caps for handle 2
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.699698Z.699698: Parsing chunk: rt/p2p'/></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.699771Z.699771: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='527118674691' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='initiate' id='2141358697'
        * description xmlns='http://www.google.com/session/share'
            * manifest
                * file size='16'
                    * name
                        "The foo.txt"
            * protocol
                * http
                    * url name='source-path'
                        "/temporary/8c6b328f-4453-48eb-b623-5663b716c544/"
                    * url name='preview-path'
                        "/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/"
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699930Z.699930: gabble_jingle_session_init (/home/smcv/src/fdo/gabble/src/jingle-session.c:194): Initializing the jingle session 0x121aec0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.699994Z.699994: create_session (/home/smcv/src/fdo/gabble/src/jingle-factory.c:518): new session (test@localhost/jingle-share/test-send-file-send-before-accept.py, 2141358697) @ 0x121aec0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700032Z.700032: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'initiate' from 'test@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700067Z.700067: _each_content_add (/home/smcv/src/fdo/gabble/src/jingle-session.c:922): namespace: http://www.google.com/session/share
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700097Z.700097: create_content (/home/smcv/src/fdo/gabble/src/jingle-session.c:850): session creating new content name (null), type 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700137Z.700137: gabble_jingle_content_init (/home/smcv/src/fdo/gabble/src/jingle-content.c:111): 0x1257a30
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700167Z.700167: gabble_jingle_share_init (/home/smcv/src/fdo/gabble/src/jingle-share.c:155): jingle share init called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700220Z.700220: parse_description (/home/smcv/src/fdo/gabble/src/jingle-share.c:303): parse description called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700272Z.700272: _gabble_jingle_content_set_media_ready (/home/smcv/src/fdo/gabble/src/jingle-content.c:1088): media ready on content: gtalk created_by_us: 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700303Z.700303: gabble_jingle_content_parse_add (/home/smcv/src/fdo/gabble/src/jingle-content.c:606): content creating new transport type GabbleJingleTransportGoogle
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700354Z.700354: parse_candidates (/home/smcv/src/fdo/gabble/src/jingle-transport-google.c:371): emitting 0 new remote candidates
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700395Z.700395: create_content (/home/smcv/src/fdo/gabble/src/jingle-session.c:888): inserting content gtalk into initiator_contents
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700428Z.700428: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121aec0 (priv = 0x121aee0) from 0 to 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700460Z.700460: gabble_jingle_session_send_rtp_info (/home/smcv/src/fdo/gabble/src/jingle-session.c:2370): Not sending <ringing/>; not using modern Jingle
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700512Z.700512: gtalk_file_collection_init (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:214): GTalk file collection init called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700553Z.700553: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x121aec0:notify::state with context 0x133bb40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700589Z.700589: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x121aec0:terminated with context 0x133c420
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700638Z.700638: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257a30:new-share-channel with context 0x133c4c0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700674Z.700674: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257a30:completed with context 0x133c560
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700806Z.700806: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x125f100:presences-updated with context 0x133c540
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700847Z.700847: gabble_file_transfer_channel_constructed (/home/smcv/src/fdo/gabble/src/ft-channel.c:451): New FT channel created: /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource/FileTransferChannel/0x122c2b0 (contact: test@localhost, initiator: test@localhost, file: "The foo.txt", size: 16)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.700963Z.700963: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x122c2b0:closed with context 0x133c680
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.701676Z.701676: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='527118674691'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.701731Z.701731: Writing xml: <iq type="result" from="test1@localhost/jingle-share/test-send-file-send-before-accept.py" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="527118674691"/>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.701994Z.701994: send_gtalk4_transport_accept (/home/smcv/src/fdo/gabble/src/jingle-content.c:475): Sending Gtalk4 'transport-accept' message to peer
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.702060Z.702060: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='524821702027'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='2141358697' type='transport-accept'
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.702109Z.702109: Writing xml: <iq type="set" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="524821702027"><session initiator="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="2141358697" type="transport-accept" xmlns="http://www.google.com/session"><transport xmlns="http://www.google.com/transport/p2p"/></session></iq>
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.702718Z.702718: add_listener: Listening on 127.0.0.1 port 38769...
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.702779Z.702779: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1311680:new-connection with context 0x133ad40
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.703477Z.703477: listener_io_in_cb: New connection from 127.0.0.1 port 45324
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.703516Z.703516: new_connection_cb (/home/smcv/src/fdo/gabble/src/ft-channel.c:2072): Client connected to local socket
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.703549Z.703549: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x125f580:disconnected with context 0x133baa0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.703585Z.703585: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x125f580:buffer-empty with context 0x133c840
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.703629Z.703629: gibber_fd_transport_block_receiving: block receiving from the transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.703670Z.703670: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133ad40 destroyed; cleaning up
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.709518Z.709518: Parsing chunk: <iq from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='527118674691' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.709597Z.709597: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='527118674691' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.709656Z.709656: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121ae30 (priv = 0x121ae50) from 1 to 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.709694Z.709694: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.709728Z.709728: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 0
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:03.713008Z.713008: add_listener: Listening on 127.0.0.1 port 50354...
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713079Z.713079: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13116c0:new-connection with context 0x133f0a0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713199Z.713199: gabble_file_transfer_channel_accept_file (/home/smcv/src/fdo/gabble/src/ft-channel.c:1749): Resume is not supported on this file transfer
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713245Z.713245: gtalk_file_collection_block_reading (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1614): Channel 0x122c2b0 blocks reading 
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713281Z.713281: gtalk_file_collection_accept (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1522): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713318Z.713318: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1945): Trying initiate or accept
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713354Z.713354: try_session_initiate_or_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1992): Contents are ready: yes
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713416Z.713416: produce_description (/home/smcv/src/fdo/gabble/src/jingle-share.c:456): produce description called
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.713535Z.713535: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='525069713474'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='2141358697' type='accept'
        * description xmlns='http://www.google.com/session/share'
            * manifest
                * file size='16'
                    * name
                        "The foo.txt"
            * protocol
                * http
                    * url name='source-path'
                        "/temporary/8c6b328f-4453-48eb-b623-5663b716c544/"
                    * url name='preview-path'
                        "/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/"
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.713630Z.713630: Writing xml: <iq type="set" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="525069713474"><session initiator="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="2141358697" type="accept" xmlns="http://www.google.com/session"><description xmlns="http://www.google.com/session/share"><manifest><file size="16"><name>The foo.txt</name></file></manifest><protocol><http><url name="source-path">/temporary/8c6b328f-4453-48eb-b623-5663b716c544/</url><url name="preview-path">/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/</url></http></protocol></description><transport xmlns="http://www.google.com/transport/p2p"/></session></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713721Z.713721: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121aec0 (priv = 0x121aee0) from 2 to 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713762Z.713762: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713801Z.713801: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713872Z.713872: gabble_jingle_content_create_share_channel (/home/smcv/src/fdo/gabble/src/jingle-content.c:685): Sending 'info' message to peer : channel gabble-1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.713933Z.713933: new_share_channel (/home/smcv/src/fdo/gabble/src/jingle-content.c:662): New Share channel 'gabble-1' with id : 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.714321Z.714321: content_new_share_channel_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:912): New Share channel gabble-1 was created and linked to id 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.714375Z.714375: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13437d0:candidate-gathering-done with context 0x1342860
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.714419Z.714419: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13437d0:component-state-changed with context 0x1342900
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.714461Z.714461: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13437d0:reliable-transport-writable with context 0x13429a0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.715145Z.715145: gabble_google_relay_resolver_resolve (/home/smcv/src/fdo/gabble/src/google-relay.c:284): No relay server provided, not creating google relay session
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.715321Z.715321: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='524302713906'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='2141358697' type='info'
        * channel xmlns='http://www.google.com/session/share' name='gabble-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.715384Z.715384: Writing xml: <iq type="set" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="524302713906"><session initiator="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="2141358697" type="info" xmlns="http://www.google.com/session"><channel name="gabble-1" xmlns="http://www.google.com/session/share"/></session></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.716281Z.716281: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 1!!!!
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.747514Z.747514: Parsing chunk: <iq to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='524821702027' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='transport-accept' id='2141358697'><transport xmlns='http://www.google.com/transport/p2p'/></session></iq><iq to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='525069713474' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='accept' id='2141358697'><description xmlns='http://www.google.com/session/share'><manifest><file size='16'><name>The foo.txt</name></file></manifest><protocol><http><url name='source-path'>/temporary/8c6b328f-4453-48eb-b623-5663b716c544/</url><url name='preview-path'>/temporary/a01f7b3d-5d6a-4cf1-92a2-298f
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.747709Z.747709: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='524821702027' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='transport-accept' id='2141358697'
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.747858Z.747858: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'transport-accept' from 'test1@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.747896Z.747896: on_transport_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1484): Ignoring 'transport-accept' action from peer
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.747958Z.747958: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='524821702027'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.747999Z.747999: Writing xml: <iq type="result" from="test@localhost/jingle-share/test-send-file-send-before-accept.py" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="524821702027"/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.748145Z.748145: Parsing chunk: b3e8b0a2/</url></http></protocol></description><transport xmlns='http://www.google.com/transport/p2p'/></session></iq><iq to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='524302713906' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='info' id='2141358697'><channel xmlns='http://www.google.com/session/share' name='gabble-1'/></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.748240Z.748240: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='525069713474' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='accept' id='2141358697'
        * description xmlns='http://www.google.com/session/share'
            * manifest
                * file size='16'
                    * name
                        "The foo.txt"
            * protocol
                * http
                    * url name='source-path'
                        "/temporary/8c6b328f-4453-48eb-b623-5663b716c544/"
                    * url name='preview-path'
                        "/temporary/a01f7b3d-5d6a-4cf1-92a2-298fb3e8b0a2/"
        * transport xmlns='http://www.google.com/transport/p2p'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.748372Z.748372: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='524302713906' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='info' id='2141358697'
        * channel xmlns='http://www.google.com/session/share' name='gabble-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748441Z.748441: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'accept' from 'test1@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748476Z.748476: on_session_accept (/home/smcv/src/fdo/gabble/src/jingle-session.c:1160): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748514Z.748514: gabble_jingle_content_parse_accept (/home/smcv/src/fdo/gabble/src/jingle-content.c:774): changing senders from both to initiator
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748547Z.748547: parse_description (/home/smcv/src/fdo/gabble/src/jingle-share.c:303): parse description called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748577Z.748577: parse_description (/home/smcv/src/fdo/gabble/src/jingle-share.c:307): Not parsing description, we already have a manifest
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748612Z.748612: parse_candidates (/home/smcv/src/fdo/gabble/src/jingle-transport-google.c:371): emitting 0 new remote candidates
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748646Z.748646: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121ae30 (priv = 0x121ae50) from 2 to 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748682Z.748682: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.748716Z.748716: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.752227Z.752227: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='525069713474'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.752270Z.752270: Writing xml: <iq type="result" from="test@localhost/jingle-share/test-send-file-send-before-accept.py" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="525069713474"/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.752373Z.752373: Parsing chunk: <iq from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524821702027' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.752442Z.752442: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524821702027' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752564Z.752564: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'info' from 'test1@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752599Z.752599: on_info (/home/smcv/src/fdo/gabble/src/jingle-session.c:1501): received info 
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752631Z.752631: gabble_jingle_content_parse_info (/home/smcv/src/fdo/gabble/src/jingle-content.c:723): parsing info message : 0x133a8d0 - (nil)
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752680Z.752680: new_share_channel (/home/smcv/src/fdo/gabble/src/jingle-content.c:662): New Share channel 'gabble-1' with id : 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752844Z.752844: content_new_share_channel_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:912): New Share channel gabble-1 was created and linked to id 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752889Z.752889: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13671d0:candidate-gathering-done with context 0x1342660
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752927Z.752927: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13671d0:component-state-changed with context 0x133c860
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.752967Z.752967: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x13671d0:reliable-transport-writable with context 0x133ef00
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.755263Z.755263: gabble_google_relay_resolver_resolve (/home/smcv/src/fdo/gabble/src/google-relay.c:284): No relay server provided, not creating google relay session
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.755341Z.755341: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='524302713906'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.755385Z.755385: Writing xml: <iq type="result" from="test@localhost/jingle-share/test-send-file-send-before-accept.py" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="524302713906"/>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.756292Z.756292: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 1!!!!
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.788918Z.788918: Parsing chunk: <iq from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='525069713474' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'/><iq from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524302713906' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.789022Z.789022: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='525069713474' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:03.789087Z.789087: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='524302713906' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.789152Z.789152: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121aec0 (priv = 0x121aee0) from 3 to 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.789192Z.789192: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.789229Z.789229: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:03.789263Z.789263: gabble_jingle_session_send_rtp_info (/home/smcv/src/fdo/gabble/src/jingle-session.c:2370): Not sending <active/>; not using modern Jingle
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505383Z.505383: timeout_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:824): Request 0x12c8550 timed out, notifying callback 0x45c210
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505456Z.505456: pipeline_reply_cb (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1380): called for entry 0x1288e40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505493Z.505493: delete_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:788): Discarding request 0x12c8550
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505534Z.505534: gabble_request_pipeline_go (/home/smcv/src/fdo/gabble/src/request-pipeline.c:388): called; 0 pending items, 0 items in flight
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505567Z.505567: timeout_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:824): Request 0x130f090 timed out, notifying callback 0x45c210
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505598Z.505598: pipeline_reply_cb (/home/smcv/src/fdo/gabble/src/vcard-manager.c:1380): called for entry 0x1311440
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505629Z.505629: delete_request (/home/smcv/src/fdo/gabble/src/vcard-manager.c:788): Discarding request 0x130f090
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.505664Z.505664: gabble_request_pipeline_go (/home/smcv/src/fdo/gabble/src/request-pipeline.c:388): called; 0 pending items, 0 items in flight
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.731197Z.731197: nice_candidate_gathering_done (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:586): libnice candidate gathering done!!!!
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.731257Z.731257: content_new_remote_candidates_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:503): Got new remote candidates : 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.731292Z.731292: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257a30:new-candidates with context 0x128e720
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.731350Z.731350: gabble_jingle_content_add_candidates (/home/smcv/src/fdo/gabble/src/jingle-content.c:907): called content: gtalk created_by_us: 0
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.731589Z.731589: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='526623731515'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='2141358697' type='transport-info'
        * transport xmlns='http://www.google.com/transport/p2p'
            * candidate address='192.168.122.1' port='47899' username='yvw1wAOm8wKs506u' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
            * candidate address='172.23.14.205' port='60776' username='SPFHRU89XlCy5Yj1' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
            * candidate address='172.23.14.114' port='35975' username='f+KOxyOBwCN4fvON' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.731690Z.731690: Writing xml: <iq type="set" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="526623731515"><session initiator="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="2141358697" type="transport-info" xmlns="http://www.google.com/session"><transport xmlns="http://www.google.com/transport/p2p"><candidate address="192.168.122.1" port="47899" username="yvw1wAOm8wKs506u" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/><candidate address="172.23.14.205" port="60776" username="SPFHRU89XlCy5Yj1" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/><candidate address="172.23.14.114" port="35975" username="f+KOxyOBwCN4fvON" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/></transport></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.733911Z.733911: Parsing chunk: <iq to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='526623731515' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='transport-info' id='2141358697'><transport xmlns='http://www.google.com/transport/p2p'><candidate username='yvw1wAOm8wKs506u' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='192.168.122.1' password='' type='local' port='47899' name='gabble-1'/><candidate username='SPFHRU89XlCy5Yj1' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.205' password='' type='local' port='60776' name='gabble-1'/><candidate username='f+KOxyOBwCN4fvON' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.114' password='' type='local' port='35975' name='gabble-1'/></transport></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.734128Z.734128: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='526623731515' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='transport-info' id='2141358697'
        * transport xmlns='http://www.google.com/transport/p2p'
            * candidate username='yvw1wAOm8wKs506u' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='192.168.122.1' password='' type='local' port='47899' name='gabble-1'
            * candidate username='SPFHRU89XlCy5Yj1' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.205' password='' type='local' port='60776' name='gabble-1'
            * candidate username='f+KOxyOBwCN4fvON' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.114' password='' type='local' port='35975' name='gabble-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.734227Z.734227: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'transport-info' from 'test1@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.734292Z.734292: parse_candidates (/home/smcv/src/fdo/gabble/src/jingle-transport-google.c:371): emitting 3 new remote candidates
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.734360Z.734360: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='526623731515'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.734400Z.734400: Writing xml: <iq type="result" from="test@localhost/jingle-share/test-send-file-send-before-accept.py" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="526623731515"/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.735247Z.735247: Parsing chunk: <iq from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='526623731515' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.735320Z.735320: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='526623731515' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.771734Z.771734: nice_candidate_gathering_done (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:586): libnice candidate gathering done!!!!
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.771773Z.771773: content_new_remote_candidates_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:503): Got new remote candidates : 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.771870Z.771870: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 2!!!!
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.772538Z.772538: gabble_signal_connect_weak (/home/smcv/src/fdo/gabble/src/util.c:676): connecting to 0x1257980:new-candidates with context 0x137bae0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.772598Z.772598: gabble_jingle_content_add_candidates (/home/smcv/src/fdo/gabble/src/jingle-content.c:907): called content: share created_by_us: 1
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.772775Z.772775: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='526862772710'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' id='2141358697' type='transport-info'
        * transport xmlns='http://www.google.com/transport/p2p'
            * candidate address='192.168.122.1' port='50126' username='CZBWBO3EE9DX3LMT' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
            * candidate address='172.23.14.205' port='37209' username='PYd0gu9lCBizsYUu' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
            * candidate address='172.23.14.114' port='41720' username='BvnTePF0TzRFfdhh' password='' preference='0.000015' protocol='udp' type='local' component='1' network='0' generation='0' name='gabble-1'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.772869Z.772869: Writing xml: <iq type="set" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="526862772710"><session initiator="test@localhost/Resource" id="2141358697" type="transport-info" xmlns="http://www.google.com/session"><transport xmlns="http://www.google.com/transport/p2p"><candidate address="192.168.122.1" port="50126" username="CZBWBO3EE9DX3LMT" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/><candidate address="172.23.14.205" port="37209" username="PYd0gu9lCBizsYUu" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/><candidate address="172.23.14.114" port="41720" username="BvnTePF0TzRFfdhh" password="" preference="0.000015" protocol="udp" type="local" component="1" network="0" generation="0" name="gabble-1"/></transport></session></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.773319Z.773319: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 3!!!!
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.773924Z.773924: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 4!!!!
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.774959Z.774959: Parsing chunk: <iq to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='526862772710' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='transport-info' id='2141358697'><transport xmlns='http://www.google.com/transport/p2p'><candidate username='CZBWBO3EE9DX3LMT' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='192.168.122.1' password='' type='local' port='50126' name='gabble-1'/><candidate username='PYd0gu9lCBizsYUu' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.205' password='' type='local' port='37209' name='gabble-1'/><candidate username='BvnTePF0TzRFfdhh' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.114' password='' type='local' port='41720' name='gabble-1'/></transport></session></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.775194Z.775194: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='526862772710' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='transport-info' id='2141358697'
        * transport xmlns='http://www.google.com/transport/p2p'
            * candidate username='CZBWBO3EE9DX3LMT' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='192.168.122.1' password='' type='local' port='50126' name='gabble-1'
            * candidate username='PYd0gu9lCBizsYUu' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.205' password='' type='local' port='37209' name='gabble-1'
            * candidate username='BvnTePF0TzRFfdhh' protocol='udp' network='0' generation='0' component='1' preference='0.000015' address='172.23.14.114' password='' type='local' port='41720' name='gabble-1'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.775291Z.775291: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'transport-info' from 'test@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.775342Z.775342: parse_candidates (/home/smcv/src/fdo/gabble/src/jingle-transport-google.c:371): emitting 3 new remote candidates
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.775377Z.775377: content_new_remote_candidates_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:503): Got new remote candidates : 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.775454Z.775454: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 2!!!!
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.776149Z.776149: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='526862772710'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.776197Z.776197: Writing xml: <iq type="result" from="test1@localhost/jingle-share/test-send-file-send-before-accept.py" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="526862772710"/>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.776582Z.776582: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 3!!!!
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:06.777596Z.777596: nice_component_state_changed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:652): libnice component state changed 4!!!!
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.777784Z.777784: Parsing chunk: <iq from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='526862772710' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:06.777851Z.777851: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='526862772710' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:08.506951Z.506951: gabble_presence_cache_end_unsure_period (/home/smcv/src/fdo/gabble/src/presence-cache.c:470): 0x125f000
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:08.507032Z.507032: gabble_presence_cache_end_unsure_period (/home/smcv/src/fdo/gabble/src/presence-cache.c:470): 0x125f100
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.875886Z.875886: get_next_manifest_entry (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:697): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876031Z.876031: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876065Z.876065: channel_open (/home/smcv/src/fdo/gabble/src/ft-channel.c:959): Channel open
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876329Z.876329: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1058): Found server headers line (22) : Connection: Keep-Alive
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876366Z.876366: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1058): Found server headers line (17) : Content-Length: 0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876398Z.876398: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1058): Found server headers line (72) : Host: test@localhost/jingle-share/test-send-file-send-before-accept.py:0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876430Z.876430: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1058): Found server headers line (39) : User-Agent: Telepathy Gabble 0.16.999.1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876461Z.876461: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1058): Found server headers line (0) : 
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876490Z.876490: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1074): Found empty line, received request : GET /temporary/8c6b328f-4453-48eb-b623-5663b716c544/The%20foo.txt HTTP/1.1 
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876537Z.876537: http_data_received (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1105): Found valid filename, result : 200
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876638Z.876638: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876670Z.876670: channel_open (/home/smcv/src/fdo/gabble/src/ft-channel.c:959): Channel open
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:09.876746Z.876746: gibber_fd_transport_block_receiving: unblock receiving from the transport
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:09.876822Z.876822: gibber_fd_transport_read: Received 16 bytes
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876889Z.876889: transport_handler (/home/smcv/src/fdo/gabble/src/ft-channel.c:1957): All the file has been sent.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.876921Z.876921: gtalk_file_collection_completed (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1651): called
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:09.876967Z.876967: _channel_io_in: Failed to read from the transport, closing..
** (telepathy-gabble:19315): DEBUG: 2012-05-07T17:49:09.876992Z.876992: _do_disconnect: Closing the fd transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:09.877078Z.877078: transport_disconnected_cb (/home/smcv/src/fdo/gabble/src/ft-channel.c:2018): transport to local socket has been disconnected
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:23.505675Z.505675: disco_items_cb (/home/smcv/src/fdo/gabble/src/disco.c:726): Got error on items request: Request for items on localhost timed out
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:23.505788Z.505788: disco_done_cb (/home/smcv/src/fdo/gabble/src/search-manager.c:137): Disco is done; complete pending requests
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:23.505830Z.505830: disco_items_cb (/home/smcv/src/fdo/gabble/src/disco.c:726): Got error on items request: Request for items on localhost timed out
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:23.505866Z.505866: disco_done_cb (/home/smcv/src/fdo/gabble/src/search-manager.c:137): Disco is done; complete pending requests
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.884808Z.884808: tp_base_connection_change_status: was 0, now 2, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.884862Z.884862: tp_base_connection_change_status: emitting status-changed to 2, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885095Z.885095: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1692): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885148Z.885148: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1720): removing callbacks
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885207Z.885207: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:192): disconnected, closing room lists
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885238Z.885238: gabble_roomlist_manager_close_all (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:86): 0x1213ac0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885272Z.885272: gabble_search_manager_close_all (/home/smcv/src/fdo/gabble/src/search-manager.c:100): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885306Z.885306: gabble_auth_manager_close_all (/home/smcv/src/fdo/gabble/src/auth-manager.c:89): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885337Z.885337: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885368Z.885368: gabble_muc_factory_close_all (/home/smcv/src/fdo/gabble/src/muc-factory.c:887): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885411Z.885411: gabble_private_tubes_factory_close_all (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:377): closing 1-1 tubes channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885463Z.885463: gabble_media_factory_close_all (/home/smcv/src/fdo/gabble/src/media-factory.c:424): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885535Z.885535: close_session_and_transport (/home/smcv/src/fdo/gabble/src/ft-channel.c:882): Closing session and transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885566Z.885566: gtalk_file_collection_terminate (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1668): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885599Z.885599: gtalk_file_collection_dispose (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:248): dispose called
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.885704Z.885704: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='set' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' id='525101885666'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' id='2141358697' type='terminate'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.885755Z.885755: Writing xml: <iq type="set" to="test1@localhost/jingle-share/test-send-file-send-before-accept.py" id="525101885666"><session initiator="test@localhost/Resource" id="2141358697" type="terminate" xmlns="http://www.google.com/session"/></iq>
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885807Z.885807: gabble_jingle_session_terminate (/home/smcv/src/fdo/gabble/src/jingle-session.c:2155): we are terminating this session
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885862Z.885862: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121ae30 (priv = 0x121ae50) from 4 to 5
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885900Z.885900: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885938Z.885938: session_terminated_cb (/home/smcv/src/fdo/gabble/src/jingle-factory.c:591): removing terminated session with key test1@localhost/jingle-share/test-send-file-send-before-accept.py
2141358697
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.885977Z.885977: gabble_jingle_session_dispose (/home/smcv/src/fdo/gabble/src/jingle-session.c:236): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886014Z.886014: gabble_jingle_share_dispose (/home/smcv/src/fdo/gabble/src/jingle-share.c:171): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886045Z.886045: gabble_jingle_content_dispose (/home/smcv/src/fdo/gabble/src/jingle-content.c:132): 0x1257980
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886079Z.886079: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x132a440 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886110Z.886110: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1325e00 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886139Z.886139: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x137bae0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886189Z.886189: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x13297a0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886221Z.886221: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1325ea0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886253Z.886253: free_share_channel (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:992): Freeing jingle Share channel
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886381Z.886381: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1342660 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886414Z.886414: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133c860 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886443Z.886443: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133ef00 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886483Z.886483: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133baa0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886514Z.886514: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133c840 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886575Z.886575: file_channel_closed_cb (/home/smcv/src/fdo/gabble/src/ft-manager.c:286): Removing channel /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/FileTransferChannel/0x122c180 with test1@localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886619Z.886619: gabble_file_transfer_channel_dispose (/home/smcv/src/fdo/gabble/src/ft-channel.c:819): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886649Z.886649: close_session_and_transport (/home/smcv/src/fdo/gabble/src/ft-channel.c:882): Closing session and transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886686Z.886686: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x132a500 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886734Z.886734: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1332980 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.886841Z.886841: connection_shut_down (/home/smcv/src/fdo/gabble/src/connection.c:2344): connection may still be open; closing it: 0x124e010
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.886880Z.886880: wocky_c2s_porter_close_async: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:1488: Sending queue is not empty. Flushing it before closing the connection.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.887342Z.887342: close_if_waiting: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:672: Queue has been flushed. Closing the connection.
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.887381Z.887381: wocky_xmpp_writer_stream_close: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:325: Writing stream close: </stream:stream>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.888025Z.888025: Parsing chunk: <iq to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='525101885666' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'><session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='terminate' id='2141358697'/></iq>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.888122Z.888122: _end_element_ns: Received stanza
* iq xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='set' id='525101885666' from='test@localhost/jingle-share/test-send-file-send-before-accept.py'
    * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='terminate' id='2141358697'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888197Z.888197: gabble_jingle_session_parse (/home/smcv/src/fdo/gabble/src/jingle-session.c:1661): jingle action 'terminate' from 'test@localhost/jingle-share/test-send-file-send-before-accept.py' in session '2141358697' dialect 2 state 4
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888234Z.888234: on_session_terminate (/home/smcv/src/fdo/gabble/src/jingle-session.c:1386): remote end terminated the session with reason unknown and text '(none)'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888267Z.888267: set_state (/home/smcv/src/fdo/gabble/src/jingle-session.c:2073): Setting state of JingleSession: 0x121aec0 (priv = 0x121aee0) from 4 to 5
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888303Z.888303: jingle_session_state_changed_cb (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:422): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888340Z.888340: session_terminated_cb (/home/smcv/src/fdo/gabble/src/jingle-factory.c:591): removing terminated session with key test@localhost/jingle-share/test-send-file-send-before-accept.py
2141358697
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888380Z.888380: gabble_file_transfer_channel_gtalk_file_collection_state_changed (/home/smcv/src/fdo/gabble/src/ft-channel.c:1289): gtalk ft state changed to 3
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888494Z.888494: close_session_and_transport (/home/smcv/src/fdo/gabble/src/ft-channel.c:882): Closing session and transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888527Z.888527: gtalk_file_collection_terminate (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:1668): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888560Z.888560: gtalk_file_collection_dispose (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:248): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888590Z.888590: gabble_jingle_session_terminate (/home/smcv/src/fdo/gabble/src/jingle-session.c:2121): session already terminated, ignoring terminate request
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888638Z.888638: free_share_channel (/home/smcv/src/fdo/gabble/src/gtalk-file-collection.c:992): Freeing jingle Share channel
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888742Z.888742: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1342860 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888776Z.888776: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x1342900 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888806Z.888806: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x13429a0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888840Z.888840: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x133bb40 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888872Z.888872: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x133c420 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888903Z.888903: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x133c4c0 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.888977Z.888977: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x133c560 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889012Z.889012: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x128e720 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889064Z.889064: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133f0a0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889100Z.889100: gabble_jingle_session_dispose (/home/smcv/src/fdo/gabble/src/jingle-session.c:236): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889134Z.889134: gabble_jingle_share_dispose (/home/smcv/src/fdo/gabble/src/jingle-share.c:171): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889165Z.889165: gabble_jingle_content_dispose (/home/smcv/src/fdo/gabble/src/jingle-content.c:132): 0x1257a30
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.889242Z.889242: _write_node_tree: Serializing tree:
* iq xmlns='jabber:client' type='result' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' to='test@localhost/jingle-share/test-send-file-send-before-accept.py' id='525101885666'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.889282Z.889282: Writing xml: <iq type="result" from="test1@localhost/jingle-share/test-send-file-send-before-accept.py" to="test@localhost/jingle-share/test-send-file-send-before-accept.py" id="525101885666"/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.889432Z.889432: Parsing chunk: <presence to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='unavailable'/>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.889499Z.889499: _end_element_ns: Received stanza
* presence xmlns='jabber:client' to='test1@localhost/jingle-share/test-send-file-send-before-accept.py' from='test@localhost/jingle-share/test-send-file-send-before-accept.py' type='unavailable'
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889576Z.889576: gabble_presence_cache_do_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:2085): test@localhost (2) resource jingle-share/test-send-file-send-before-accept.py prio 0 presence 1 (unknown) message "<null>"
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.889672Z.889672: emit_capabilities_update (/home/smcv/src/fdo/gabble/src/presence-cache.c:1150): Emitting caps update for handle 2
  --removed--
  Feature: http://www.google.com/xmpp/protocol/session
  Feature: urn:xmpp:jingle:transports:raw-udp:1
  Feature: http://jabber.org/protocol/jingle
  Feature: urn:xmpp:jingle:1
  Feature: http://jabber.org/protocol/chatstates
  Feature: http://jabber.org/protocol/nick
  Feature: http://jabber.org/protocol/nick+notify
  Feature: http://jabber.org/protocol/si
  Feature: http://jabber.org/protocol/ibb
  Feature: http://telepathy.freedesktop.org/xmpp/tubes
  Feature: http://jabber.org/protocol/bytestreams
  Feature: jabber:iq:version
  Feature: http://www.google.com/transport/p2p
  Feature: urn:xmpp:jingle:transports:ice-udp:1
  Feature: http://google.com/xmpp/protocol/share/v1
  --end--
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:24.890031Z.890031: tp_presence_mixin_emit_presence_update: called.
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:24.890065Z.890065: construct_simple_presence_hash: called.
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890298Z.890298: gabble_presence_cache_maybe_remove (/home/smcv/src/fdo/gabble/src/presence-cache.c:2034): discarding cached presence for unavailable jid test@localhost
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.890382Z.890382: Parsing chunk: <iq from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='525101885666' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'/></stream:stream>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.890450Z.890450: _end_element_ns: Received stanza
* iq xmlns='jabber:client' from='test1@localhost/jingle-share/test-send-file-send-before-accept.py' type='result' id='525101885666' to='test@localhost/jingle-share/test-send-file-send-before-accept.py'
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.890484Z.890484: _end_element_ns: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:602: Stream ended
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.890569Z.890569: stanza_received_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:1294: Error receiving stanza: Connection has been closed for reading stanzas
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890635Z.890635: closed_cb (/home/smcv/src/fdo/gabble/src/connection.c:2292): close failed: Connection has been closed for reading stanzas
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:24.890726Z.890726: connection_shutdown_finished_cb: dereferenced connection
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890773Z.890773: gabble_connection_dispose (/home/smcv/src/fdo/gabble/src/connection.c:1268): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890813Z.890813: gabble_bytestream_factory_dispose (/home/smcv/src/fdo/gabble/src/bytestream-factory.c:681): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890869Z.890869: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x1256320 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890904Z.890904: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b020 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890938Z.890938: gabble_disco_dispose (/home/smcv/src/fdo/gabble/src/disco.c:227): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.890972Z.890972: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x129fac0 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891004Z.891004: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x129fb60 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891035Z.891035: gabble_disco_finalize (/home/smcv/src/fdo/gabble/src/disco.c:254): called with 0x1213b80
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891068Z.891068: gabble_request_pipeline_dispose (/home/smcv/src/fdo/gabble/src/request-pipeline.c:275): disposing request-pipeline
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891115Z.891115: delete_item (/home/smcv/src/fdo/gabble/src/request-pipeline.c:178): deleting item 0x12c8150
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891150Z.891150: gabble_vcard_manager_dispose (/home/smcv/src/fdo/gabble/src/vcard-manager.c:613): 0x124b470
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891204Z.891204: gabble_vcard_manager_finalize (/home/smcv/src/fdo/gabble/src/vcard-manager.c:644): 0x124b470
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891236Z.891236: gabble_jingle_factory_dispose (/home/smcv/src/fdo/gabble/src/jingle-factory.c:133): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891361Z.891361: gabble_presence_cache_dispose (/home/smcv/src/fdo/gabble/src/presence-cache.c:587): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891514Z.891514: gabble_presence_cache_finalize (/home/smcv/src/fdo/gabble/src/presence-cache.c:618): called with 0x125f000
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891618Z.891618: gabble_roster_dispose (/home/smcv/src/fdo/gabble/src/roster.c:201): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891648Z.891648: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1692): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891681Z.891681: gabble_roster_finalize (/home/smcv/src/fdo/gabble/src/roster.c:233): called with 0x1254050
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891709Z.891709: gabble_im_factory_dispose (/home/smcv/src/fdo/gabble/src/im-factory.c:121): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891741Z.891741: gabble_roomlist_manager_dispose (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:128): running
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891766Z.891766: gabble_roomlist_manager_close_all (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:86): 0x1213ac0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891796Z.891796: gabble_search_manager_dispose (/home/smcv/src/fdo/gabble/src/search-manager.c:214): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891822Z.891822: gabble_search_manager_close_all (/home/smcv/src/fdo/gabble/src/search-manager.c:100): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891852Z.891852: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x12418c0 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891882Z.891882: gabble_auth_manager_dispose (/home/smcv/src/fdo/gabble/src/auth-manager.c:158): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891907Z.891907: gabble_auth_manager_close_all (/home/smcv/src/fdo/gabble/src/auth-manager.c:89): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891939Z.891939: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x1241980 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.891969Z.891969: gabble_server_tls_manager_dispose (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:381): 0x1220200
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892000Z.892000: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x1256120 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892028Z.892028: gabble_server_tls_manager_finalize (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:399): 0x1220200
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892057Z.892057: gabble_muc_factory_dispose (/home/smcv/src/fdo/gabble/src/muc-factory.c:154): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892082Z.892082: gabble_muc_factory_close_all (/home/smcv/src/fdo/gabble/src/muc-factory.c:887): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892116Z.892116: gabble_private_tubes_factory_dispose (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:198): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892154Z.892154: gabble_private_tubes_factory_close_all (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:377): closing 1-1 tubes channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892187Z.892187: gabble_media_factory_dispose (/home/smcv/src/fdo/gabble/src/media-factory.c:159): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892212Z.892212: gabble_media_factory_close_all (/home/smcv/src/fdo/gabble/src/media-factory.c:424): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892292Z.892292: gabble_connection_finalize (/home/smcv/src/fdo/gabble/src/connection.c:1345): called with 0x124e010
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.892319Z.892319: tp_contacts_mixin_finalize: 0x124e010
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:24.892345Z.892345: tp_presence_mixin_finalize: 0x124e010
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.892395Z.892395: gabble_capabilities_finalize (/home/smcv/src/fdo/gabble/src/capabilities.c:327): 0x124e010
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.892549Z.892549: wocky_c2s_porter_finalize: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:568: finalize porter 0x12c1890
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.895387Z.895387: tp_base_connection_change_status: was 0, now 2, for reason 1
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.895424Z.895424: tp_base_connection_change_status: emitting status-changed to 2, for reason 1
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895603Z.895603: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1692): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895650Z.895650: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1720): removing callbacks
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895702Z.895702: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:192): disconnected, closing room lists
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895734Z.895734: gabble_roomlist_manager_close_all (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:86): 0x1213d40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895768Z.895768: gabble_search_manager_close_all (/home/smcv/src/fdo/gabble/src/search-manager.c:100): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895801Z.895801: gabble_auth_manager_close_all (/home/smcv/src/fdo/gabble/src/auth-manager.c:89): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895833Z.895833: connection_status_changed_cb (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:123): Connection status changed, now 2
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895864Z.895864: gabble_muc_factory_close_all (/home/smcv/src/fdo/gabble/src/muc-factory.c:887): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895906Z.895906: gabble_private_tubes_factory_close_all (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:377): closing 1-1 tubes channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.895956Z.895956: gabble_media_factory_close_all (/home/smcv/src/fdo/gabble/src/media-factory.c:424): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896019Z.896019: file_channel_closed_cb (/home/smcv/src/fdo/gabble/src/ft-manager.c:286): Removing channel /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource/FileTransferChannel/0x122c2b0 with test@localhost
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896064Z.896064: gabble_file_transfer_channel_dispose (/home/smcv/src/fdo/gabble/src/ft-channel.c:819): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896095Z.896095: close_session_and_transport (/home/smcv/src/fdo/gabble/src/ft-channel.c:882): Closing session and transport
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896149Z.896149: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x133c540 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896183Z.896183: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x133c680 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.896286Z.896286: connection_shut_down (/home/smcv/src/fdo/gabble/src/connection.c:2344): connection may still be open; closing it: 0x124e370
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.896326Z.896326: wocky_xmpp_writer_stream_close: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-writer.c:325: Writing stream close: </stream:stream>

(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.897177Z.897177: Parsing chunk: </stream:stream>
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.897212Z.897212: _end_element_ns: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-xmpp-reader.c:602: Stream ended
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.897247Z.897247: stanza_received_cb: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:1290: Remote connection has been closed
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897304Z.897304: closed_cb (/home/smcv/src/fdo/gabble/src/connection.c:2310): connection properly closed
(telepathy-gabble:19315): tp-glib/params-DEBUG: 2012-05-07T17:49:24.897352Z.897352: connection_shutdown_finished_cb: dereferenced connection
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897396Z.897396: gabble_connection_dispose (/home/smcv/src/fdo/gabble/src/connection.c:1268): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897428Z.897428: gabble_bytestream_factory_dispose (/home/smcv/src/fdo/gabble/src/bytestream-factory.c:681): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897481Z.897481: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b760 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897515Z.897515: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b700 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897549Z.897549: gabble_disco_dispose (/home/smcv/src/fdo/gabble/src/disco.c:227): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897582Z.897582: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x12fbc40 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897614Z.897614: instance_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:632): instance for 0x12f5c80 destroyed; cleaning up
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897644Z.897644: gabble_disco_finalize (/home/smcv/src/fdo/gabble/src/disco.c:254): called with 0x1213d80
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897675Z.897675: gabble_request_pipeline_dispose (/home/smcv/src/fdo/gabble/src/request-pipeline.c:275): disposing request-pipeline
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897704Z.897704: delete_item (/home/smcv/src/fdo/gabble/src/request-pipeline.c:178): deleting item 0x130ed50
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897737Z.897737: gabble_vcard_manager_dispose (/home/smcv/src/fdo/gabble/src/vcard-manager.c:613): 0x124b5c0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897772Z.897772: gabble_vcard_manager_finalize (/home/smcv/src/fdo/gabble/src/vcard-manager.c:644): 0x124b5c0
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897803Z.897803: gabble_jingle_factory_dispose (/home/smcv/src/fdo/gabble/src/jingle-factory.c:133): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.897887Z.897887: gabble_presence_cache_dispose (/home/smcv/src/fdo/gabble/src/presence-cache.c:587): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898054Z.898054: gabble_presence_cache_finalize (/home/smcv/src/fdo/gabble/src/presence-cache.c:618): called with 0x125f100
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898169Z.898169: gabble_roster_dispose (/home/smcv/src/fdo/gabble/src/roster.c:201): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898203Z.898203: gabble_roster_close_all (/home/smcv/src/fdo/gabble/src/roster.c:1692): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898239Z.898239: gabble_roster_finalize (/home/smcv/src/fdo/gabble/src/roster.c:233): called with 0x1254160
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898270Z.898270: gabble_im_factory_dispose (/home/smcv/src/fdo/gabble/src/im-factory.c:121): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898305Z.898305: gabble_roomlist_manager_dispose (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:128): running
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898334Z.898334: gabble_roomlist_manager_close_all (/home/smcv/src/fdo/gabble/src/roomlist-manager.c:86): 0x1213d40
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898368Z.898368: gabble_search_manager_dispose (/home/smcv/src/fdo/gabble/src/search-manager.c:214): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898398Z.898398: gabble_search_manager_close_all (/home/smcv/src/fdo/gabble/src/search-manager.c:100): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898432Z.898432: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b500 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898466Z.898466: gabble_auth_manager_dispose (/home/smcv/src/fdo/gabble/src/auth-manager.c:158): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898496Z.898496: gabble_auth_manager_close_all (/home/smcv/src/fdo/gabble/src/auth-manager.c:89): called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898532Z.898532: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b080 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898566Z.898566: gabble_server_tls_manager_dispose (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:381): 0x1220340
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898600Z.898600: user_data_destroyed_cb (/home/smcv/src/fdo/gabble/src/util.c:645): user_data for 0x126b120 destroyed; disconnecting
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898633Z.898633: gabble_server_tls_manager_finalize (/home/smcv/src/fdo/gabble/src/server-tls-manager.c:399): 0x1220340
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898665Z.898665: gabble_muc_factory_dispose (/home/smcv/src/fdo/gabble/src/muc-factory.c:154): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898694Z.898694: gabble_muc_factory_close_all (/home/smcv/src/fdo/gabble/src/muc-factory.c:887): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898732Z.898732: gabble_private_tubes_factory_dispose (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:198): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898763Z.898763: gabble_private_tubes_factory_close_all (/home/smcv/src/fdo/gabble/src/private-tubes-factory.c:377): closing 1-1 tubes channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898798Z.898798: gabble_media_factory_dispose (/home/smcv/src/fdo/gabble/src/media-factory.c:159): dispose called
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898827Z.898827: gabble_media_factory_close_all (/home/smcv/src/fdo/gabble/src/media-factory.c:424): closing channels
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.898916Z.898916: gabble_connection_finalize (/home/smcv/src/fdo/gabble/src/connection.c:1345): called with 0x124e370
(telepathy-gabble:19315): tp-glib/connection-DEBUG: 2012-05-07T17:49:24.898960Z.898960: tp_contacts_mixin_finalize: 0x124e370
(telepathy-gabble:19315): tp-glib/presence-DEBUG: 2012-05-07T17:49:24.898989Z.898989: tp_presence_mixin_finalize: 0x124e370
(telepathy-gabble:19315): gabble-DEBUG: 2012-05-07T17:49:24.899046Z.899046: gabble_capabilities_finalize (/home/smcv/src/fdo/gabble/src/capabilities.c:327): 0x124e370
(telepathy-gabble:19315): wocky-DEBUG: 2012-05-07T17:49:24.899265Z.899265: wocky_c2s_porter_finalize: /home/smcv/src/fdo/gabble/lib/ext/wocky/wocky/wocky-c2s-porter.c:568: finalize porter 0x12c1970
tp-glib-Message: 2012-05-07T17:49:24.947562Z.947562: Got disconnected from the session bus
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.