(process:23436): tp-glib/proxy-DEBUG: tp_proxy_dispose: 0xb4c860 (process:23436): tp-glib/proxy-DEBUG: tp_proxy_invalidate: 0xb4c860: Proxy unreferenced (process:23436): tp-glib/proxy-DEBUG: tp_proxy_finalize: 0xb4c860 (process:23436): gabble-DEBUG: 2011-01-26T13:50:53.548979Z.548979: gabble_plugin_loader_probe (plugin-loader.c:124): probing /home/cassidy/dev/telepathy-gabble/plugins/.libs (process:23436): gabble-DEBUG: 2011-01-26T13:50:53.549347Z.549347: plugin_loader_try_to_load (plugin-loader.c:61): /home/cassidy/dev/telepathy-gabble/plugins/.libs/bookmarks.so: undefined symbol: gabble_svc_gabble_plugin_bookmarks_get_type ** (process:23436): DEBUG: 2011-01-26T13:50:53.549604Z.549604: test_plugin_init: 0xb2f4e0 (process:23436): gabble-DEBUG: 2011-01-26T13:50:53.549656Z.549656: plugin_loader_try_to_load (plugin-loader.c:99): loaded 'Sidecar test plugin' version (unspecified) (/home/cassidy/dev/telepathy-gabble/plugins/.libs/test.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 ** (process:23436): DEBUG: 2011-01-26T13:50:53.549826Z.549826: gabble_plugin_create: loaded (process:23436): gabble-DEBUG: 2011-01-26T13:50:53.549884Z.549884: plugin_loader_try_to_load (plugin-loader.c:99): loaded 'Gateway registration plugin' version 0.11.5.1 (/home/cassidy/dev/telepathy-gabble/plugins/.libs/gateways.so), implementing these sidecars: org.freedesktop.Telepathy.Gabble.Plugin.Gateways (telepathy-gabble:23436): tp-glib-DEBUG: 2011-01-26T13:50:53.554000Z.554000: started version 0.11.5.1 (telepathy-glib version 0.13.10.1) (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555325Z.555325: tp_base_protocol_sanitize_parameters: using specified value for account: "test@localhost/test-send-file.py" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555371Z.555371: tp_base_protocol_sanitize_parameters: using specified value for password: (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555406Z.555406: tp_base_protocol_sanitize_parameters: using specified value for server: "localhost" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555440Z.555440: tp_base_protocol_sanitize_parameters: using specified value for resource: "Resource" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555475Z.555475: tp_base_protocol_sanitize_parameters: using default value for priority (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555526Z.555526: tp_base_protocol_sanitize_parameters: using specified value for port: 4242 (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555566Z.555566: tp_base_protocol_sanitize_parameters: using default value for old-ssl (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555596Z.555596: tp_base_protocol_sanitize_parameters: using default value for require-encryption (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555628Z.555628: tp_base_protocol_sanitize_parameters: using default value for register (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555658Z.555658: tp_base_protocol_sanitize_parameters: using default value for low-bandwidth (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555686Z.555686: tp_base_protocol_sanitize_parameters: no default value for https-proxy-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555716Z.555716: tp_base_protocol_sanitize_parameters: using default value for https-proxy-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555745Z.555745: tp_base_protocol_sanitize_parameters: no default value for fallback-conference-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555774Z.555774: tp_base_protocol_sanitize_parameters: no default value for stun-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555802Z.555802: tp_base_protocol_sanitize_parameters: using default value for stun-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555870Z.555870: tp_base_protocol_sanitize_parameters: using default value for fallback-stun-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555905Z.555905: tp_base_protocol_sanitize_parameters: using default value for fallback-stun-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555936Z.555936: tp_base_protocol_sanitize_parameters: using default value for ignore-ssl-errors (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.555965Z.555965: tp_base_protocol_sanitize_parameters: no default value for alias (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.556003Z.556003: tp_base_protocol_sanitize_parameters: using specified value for fallback-socks5-proxies: [] (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.556035Z.556035: tp_base_protocol_sanitize_parameters: using default value for keepalive-interval (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.556066Z.556066: tp_base_protocol_sanitize_parameters: using default value for org.freedesktop.Telepathy.Connection.Interface.Gabble.Decloak.DecloakAutomatically (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.556100Z.556100: tp_base_protocol_sanitize_parameters: no default value for fallback-servers (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.556229Z.556229: tp_base_connection_class_init: Initializing (TpBaseConnectionClass *)0xb71530 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.556883Z.556883: gabble_connection_class_init (connection.c:876): Initializing (GabbleConnectionClass *)0xb725d0 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.557160Z.557160: tp_presence_mixin_class_init: called. (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.557533Z.557533: tp_base_connection_init: Initializing (TpBaseConnection *)0xb7e0a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.557578Z.557578: gabble_connection_init (connection.c:482): Initializing (GabbleConnection *)0xb7e0a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.557658Z.557658: gabble_capabilities_init (capabilities.c:231): 0xb7e0a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.557952Z.557952: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0xb7e0a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.558040Z.558040: tp_base_connection_constructor: Handle repo for type #0 at (nil) (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.558071Z.558071: tp_base_connection_constructor: Handle repo for type #1 at 0xb824f0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.558099Z.558099: tp_base_connection_constructor: Handle repo for type #2 at 0xb82590 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.558126Z.558126: tp_base_connection_constructor: Handle repo for type #3 at (nil) (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.558153Z.558153: tp_base_connection_constructor: Handle repo for type #4 at (nil) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.558693Z.558693: gabble_roomlist_manager_constructed (roomlist-manager.c:210): 0xb45ac0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.558772Z.558772: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e0a0:status-changed with context 0xb7c680 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.558904Z.558904: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e0a0:status-changed with context 0xb7cae0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.559049Z.559049: gabble_server_tls_manager_constructed (server-tls-manager.c:344): Server TLS Manager constructed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.559091Z.559091: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e0a0:status-changed with context 0xb7c960 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.559407Z.559407: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e0a0:status-changed with context 0xb7c420 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559647Z.559647: tp_base_connection_constructor: Channel manager #0 at 0xb5a110 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559715Z.559715: tp_base_connection_constructor: Channel manager #1 at 0xb79e80 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559775Z.559775: tp_base_connection_constructor: Channel manager #2 at 0xb45ac0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559827Z.559827: tp_base_connection_constructor: Channel manager #3 at 0xb79e30 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559879Z.559879: tp_base_connection_constructor: Channel manager #4 at 0xb87830 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559931Z.559931: tp_base_connection_constructor: Channel manager #5 at 0xb54180 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.559986Z.559986: tp_base_connection_constructor: Channel manager #6 at 0xb790a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.560041Z.560041: tp_base_connection_constructor: Channel manager #7 at 0xb868a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.560092Z.560092: tp_base_connection_constructor: Channel manager #8 at 0xb52c00 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.560167Z.560167: tp_base_connection_constructor: Channel manager #9 at 0xb86a80 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.560229Z.560229: gabble_connection_constructor (connection.c:356): Post-construction: (GabbleConnection *)0xb7e0a0 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.560807Z.560807: tp_presence_mixin_init: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.561174Z.561174: gabble_signal_connect_weak (util.c:966): connecting to 0xb45b40:item-found with context 0xb89e20 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.561226Z.561226: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e0a0:status-changed with context 0xb89b00 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.561370Z.561370: gabble_connection_constructed (connection.c:465): defaulted resource to ceb47283 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.562012Z.562012: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test_40localhost_2fResource (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.562054Z.562054: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566367Z.566367: tp_base_protocol_sanitize_parameters: using specified value for account: "test1@localhost/test-send-file.py" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566421Z.566421: tp_base_protocol_sanitize_parameters: using specified value for password: (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566457Z.566457: tp_base_protocol_sanitize_parameters: using specified value for server: "localhost" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566490Z.566490: tp_base_protocol_sanitize_parameters: using specified value for resource: "Resource" (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566522Z.566522: tp_base_protocol_sanitize_parameters: using default value for priority (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566559Z.566559: tp_base_protocol_sanitize_parameters: using specified value for port: 4242 (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566590Z.566590: tp_base_protocol_sanitize_parameters: using default value for old-ssl (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566638Z.566638: tp_base_protocol_sanitize_parameters: using default value for require-encryption (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566673Z.566673: tp_base_protocol_sanitize_parameters: using default value for register (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566699Z.566699: tp_base_protocol_sanitize_parameters: using default value for low-bandwidth (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566725Z.566725: tp_base_protocol_sanitize_parameters: no default value for https-proxy-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566750Z.566750: tp_base_protocol_sanitize_parameters: using default value for https-proxy-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566776Z.566776: tp_base_protocol_sanitize_parameters: no default value for fallback-conference-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566801Z.566801: tp_base_protocol_sanitize_parameters: no default value for stun-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566827Z.566827: tp_base_protocol_sanitize_parameters: using default value for stun-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566854Z.566854: tp_base_protocol_sanitize_parameters: using default value for fallback-stun-server (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566881Z.566881: tp_base_protocol_sanitize_parameters: using default value for fallback-stun-port (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566907Z.566907: tp_base_protocol_sanitize_parameters: using default value for ignore-ssl-errors (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566933Z.566933: tp_base_protocol_sanitize_parameters: no default value for alias (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.566963Z.566963: tp_base_protocol_sanitize_parameters: using specified value for fallback-socks5-proxies: [] (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.567008Z.567008: tp_base_protocol_sanitize_parameters: using default value for keepalive-interval (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.567035Z.567035: tp_base_protocol_sanitize_parameters: using default value for org.freedesktop.Telepathy.Connection.Interface.Gabble.Decloak.DecloakAutomatically (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:50:53.567064Z.567064: tp_base_protocol_sanitize_parameters: no default value for fallback-servers (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567117Z.567117: tp_base_connection_init: Initializing (TpBaseConnection *)0xb7e3e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567152Z.567152: gabble_connection_init (connection.c:482): Initializing (GabbleConnection *)0xb7e3e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567185Z.567185: gabble_capabilities_init (capabilities.c:231): 0xb7e3e0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567225Z.567225: tp_base_connection_constructor: Post-construction: (TpBaseConnection *)0xb7e3e0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567294Z.567294: tp_base_connection_constructor: Handle repo for type #0 at (nil) (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567320Z.567320: tp_base_connection_constructor: Handle repo for type #1 at 0xb95540 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567346Z.567346: tp_base_connection_constructor: Handle repo for type #2 at 0xb95320 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567370Z.567370: tp_base_connection_constructor: Handle repo for type #3 at (nil) (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567393Z.567393: tp_base_connection_constructor: Handle repo for type #4 at (nil) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567550Z.567550: gabble_roomlist_manager_constructed (roomlist-manager.c:210): 0xb45cc0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567616Z.567616: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e3e0:status-changed with context 0xb96540 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567674Z.567674: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e3e0:status-changed with context 0xb9b0c0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567733Z.567733: gabble_server_tls_manager_constructed (server-tls-manager.c:344): Server TLS Manager constructed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567763Z.567763: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e3e0:status-changed with context 0xb9b220 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.567865Z.567865: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e3e0:status-changed with context 0xb9b280 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.567954Z.567954: tp_base_connection_constructor: Channel manager #0 at 0xb5a200 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568001Z.568001: tp_base_connection_constructor: Channel manager #1 at 0xb9cc00 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568042Z.568042: tp_base_connection_constructor: Channel manager #2 at 0xb45cc0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568086Z.568086: tp_base_connection_constructor: Channel manager #3 at 0xb9cca0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568140Z.568140: tp_base_connection_constructor: Channel manager #4 at 0xb878e0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568186Z.568186: tp_base_connection_constructor: Channel manager #5 at 0xb54400 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568232Z.568232: tp_base_connection_constructor: Channel manager #6 at 0xb79260 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568279Z.568279: tp_base_connection_constructor: Channel manager #7 at 0xb9ced0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568324Z.568324: tp_base_connection_constructor: Channel manager #8 at 0xb52cc0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.568373Z.568373: tp_base_connection_constructor: Channel manager #9 at 0xb9d0a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.568427Z.568427: gabble_connection_constructor (connection.c:356): Post-construction: (GabbleConnection *)0xb7e3e0 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.568721Z.568721: tp_presence_mixin_init: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.568929Z.568929: gabble_signal_connect_weak (util.c:966): connecting to 0xb45d00:item-found with context 0xb9f040 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.568972Z.568972: gabble_signal_connect_weak (util.c:966): connecting to 0xb7e3e0:status-changed with context 0xb9eea0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.569052Z.569052: gabble_connection_constructed (connection.c:465): defaulted resource to ceb47283 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.569847Z.569847: tp_base_connection_register: bus name org.freedesktop.Telepathy.Connection.gabble.jabber.test1_40localhost_2fResource (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.569928Z.569928: tp_base_connection_register: object path /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.576971Z.576971: _gabble_connection_connect (connection.c:2030): disabling SRV because "server" or "old-ssl" was specified or port was not 5222, will connect to localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577036Z.577036: _gabble_connection_connect (connection.c:2049): require-encryption is False; flipping ignore_ssl_errors to True (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577124Z.577124: _gabble_connection_connect (connection.c:2089): Start connecting (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.577447Z.577447: connector_connect_async: wocky-connector.c:2313: host: localhost; port: 4242 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.577730Z.577730: tp_base_connection_change_status: was 4294967295, now 1, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.577764Z.577764: tp_base_connection_change_status: emitting status-changed to 1, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577816Z.577816: connection_status_changed_cb (im-factory.c:428): adding callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577855Z.577855: gabble_signal_connect_weak (util.c:966): connecting to 0xb45b40:item-found with context 0xba9600 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577898Z.577898: gabble_signal_connect_weak (util.c:966): connecting to 0xb45b40:done with context 0xb89d60 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577941Z.577941: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.577976Z.577976: connection_status_changed_cb (muc-factory.c:943): adding callbacks (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.578777Z.578777: tcp_host_connected: wocky-connector.c:937: HOST connection succeeded (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.579001Z.579001: xmpp_init: wocky-connector.c:1056: sending XMPP stream open to server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.579080Z.579080: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:298: Writing stream opening: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.579290Z.579290: xmpp_init_sent_cb: wocky-connector.c:1077: waiting for stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585508Z.585508: Parsing chunk: PLAIN (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585631Z.585631: _start_element_ns: wocky-xmpp-reader.c:436: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585679Z.585679: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: version = '1.0' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585721Z.585721: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: id = '17ad29e3287a359c' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585866Z.585866: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.585942Z.585942: xmpp_init_recv_cb: wocky-connector.c:1110: TCP Connection Established: : received XMPP v1.0 stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.585993Z.585993: xmpp_init_recv_cb: wocky-connector.c:1125: waiting for feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.586074Z.586074: xmpp_features_cb: wocky-connector.c:1180: received feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.586222Z.586222: sasl_request_auth: wocky-connector.c:1309: handing over control to SASL module (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.586276Z.586276: wocky_auth_registry_start_auth_async_func: wocky-auth-registry.c:290: Choosing PLAIN as auth mechanism (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.586411Z.586411: plain_initial_response: wocky-sasl-plain.c:165: Got username and password (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.586529Z.586529: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.586683Z.586683: Writing xml: AHRlc3QAcGFzcw== (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587312Z.587312: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587390Z.587390: _end_element_ns: Received stanza * success xmlns='urn:ietf:params:xml:ns:xmpp-sasl' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587472Z.587472: auth_succeeded: wocky-sasl-auth.c:246: Authentication succeeded (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587512Z.587512: sasl_auth_done: wocky-connector.c:1344: SASL complete (success) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587545Z.587545: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587598Z.587598: xmpp_init: wocky-connector.c:1056: sending XMPP stream open to server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587642Z.587642: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:298: Writing stream opening: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.587743Z.587743: xmpp_init_sent_cb: wocky-connector.c:1077: waiting for stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590004Z.590004: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590381Z.590381: _start_element_ns: wocky-xmpp-reader.c:436: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590429Z.590429: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: version = '1.0' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590467Z.590467: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: id = '1c8a4e87eeaf442f' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590620Z.590620: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.590684Z.590684: xmpp_init_recv_cb: wocky-connector.c:1110: Authentication Completed: : received XMPP v1.0 stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590722Z.590722: xmpp_init_recv_cb: wocky-connector.c:1125: waiting for feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590794Z.590794: xmpp_features_cb: wocky-connector.c:1180: received feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590895Z.590895: iq_bind_resource: wocky-connector.c:1844: sending bind iq set stanza (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.590953Z.590953: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='697590841' * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind' * resource "Resource" (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.591027Z.591027: Writing xml: Resource (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599046Z.599046: iq_bind_resource_sent_cb: wocky-connector.c:1867: bind iq set stanza sent (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599193Z.599193: Parsing chunk: test@localhost/Resource (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599323Z.599323: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='697590841' * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind' * jid "test@localhost/Resource" (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599375Z.599375: iq_bind_resource_recv_cb: wocky-connector.c:1885: bind iq response stanza received (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599466Z.599466: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='9269599414' * session xmlns='urn:ietf:params:xml:ns:xmpp-session' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.599520Z.599520: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.600901Z.600901: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.600989Z.600989: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='9269599414' * session xmlns='urn:ietf:params:xml:ns:xmpp-session' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.601052Z.601052: connector_connected (connection.c:1778): connected (jid: test@localhost/Resource) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.601351Z.601351: wocky_ping_set_property: wocky-ping.c:87: updated ping interval to 30 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.601687Z.601687: gabble_roster_porter_available_cb (roster.c:1746): adding callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.601991Z.601991: connector_connected (connection.c:1840): Created self handle 1, our JID is test@localhost/Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602081Z.602081: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource Resource with serial 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602117Z.602117: gabble_presence_set_capabilities (presence.c:286): found resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602149Z.602149: gabble_presence_set_capabilities (presence.c:291): new serial 1, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602186Z.602186: gabble_presence_set_capabilities (presence.c:298): updating caps for resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602238Z.602238: gabble_connection_refresh_capabilities (connection.c:2350): not emitting self-presence stanza: not connected yet (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602283Z.602283: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xbcb080 for localhost (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.602371Z.602371: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='localhost' id='8355602337' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.602411Z.602411: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.602509Z.602509: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xbcb100 for test@localhost (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.602698Z.602698: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='test@localhost' id='8384602559' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.602749Z.602749: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.604043Z.604043: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.604130Z.604130: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='localhost' type='result' id='8355602337' from='localhost' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.604207Z.604207: connection_disco_cb: got: * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.604247Z.604247: connection_disco_cb (connection.c:2766): set features flags to 0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.604330Z.604330: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='8337604303' * query xmlns='jabber:iq:privacy' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.604376Z.604376: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.605305Z.605305: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.605476Z.605476: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test@localhost' type='result' id='8384602559' from='test@localhost' * query xmlns='http://jabber.org/protocol/disco#info' * identity category='pubsub' type='pep' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.605547Z.605547: bare_jid_disco_cb (connection.c:1657): Server advertises PEP support in our jid features (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.606394Z.606394: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.606470Z.606470: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='error' id='8337604303' * query xmlns='jabber:iq:privacy' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.606537Z.606537: get_existing_privacy_lists_cb (conn-presence.c:1019): Error getting privacy lists: Unknown or invalid XMPP error (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.606741Z.606741: gabble_presence_cache_add_own_caps (presence-cache.c:2110): caching our own caps (http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8=) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.606881Z.606881: _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='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.606933Z.606933: Writing xml: (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.607080Z.607080: tp_base_connection_change_status: was 1, now 0, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.607112Z.607112: tp_base_connection_change_status: emitting status-changed to 0, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607172Z.607172: connection_status_changed_cb (roster.c:1778): requesting roster (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.607258Z.607258: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='1029607232' * query xmlns='jabber:iq:roster' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.607299Z.607299: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607356Z.607356: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607406Z.607406: take_stun_server (jingle-factory.c:239): Resolving fallback STUN server stun.telepathy.im:3478 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607493Z.607493: gabble_disco_conn_status_changed_cb (disco.c:921): connected, initiating service discovery on localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607533Z.607533: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xbcb240 for localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607649Z.607649: gabble_vcard_manager_request (vcard-manager.c:1559): Created request 0xbcdf20 to retrieve <1>'s vCard (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607695Z.607695: request_send (vcard-manager.c:1493): Cache entry 0xbcb2c0 is my own, not setting @to (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607754Z.607754: gabble_request_pipeline_enqueue (request-pipeline.c:433): enqueued new request as item 0xbcdf80 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607790Z.607790: gabble_request_pipeline_enqueue (request-pipeline.c:434): number of items in flight: 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.607829Z.607829: request_send (vcard-manager.c:1514): adding request to cache entry 0xbcb2c0 and queueing the (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.607895Z.607895: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.607925Z.607925: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.608227Z.608227: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.608500Z.608500: sidecars_conn_status_changed_cb (conn-sidecars.c:322): connected; requesting sidecars from plugins (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.608690Z.608690: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='localhost' id='1067607591' * query xmlns='http://jabber.org/protocol/disco#items' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.608738Z.608738: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.608827Z.608827: stun_server_resolved_cb (jingle-factory.c:194): Resolved STUN server stun.telepathy.im:3478 to 6.7.8.9:3478 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.608918Z.608918: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='180608429' * pubsub xmlns='http://jabber.org/protocol/pubsub' * publish node='http://laptop.org/xmpp/activities' * item * activities xmlns='http://laptop.org/xmpp/activities' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.608974Z.608974: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.609077Z.609077: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='161608475' * 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:23436): wocky-DEBUG: 2011-01-26T13:50:53.609146Z.609146: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.609256Z.609256: gabble_request_pipeline_go (request-pipeline.c:390): called; 1 pending items, 0 items in flight (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.609291Z.609291: send_next_request (request-pipeline.c:361): processing request 0xbcdf80 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.609349Z.609349: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='1074609321' * vCard xmlns='vcard-temp' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.609389Z.609389: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.616219Z.616219: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.616379Z.616379: _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#XtViuVkOlKOArsru2DTS3ZoGWc8=' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.616490Z.616490: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.616621Z.616621: connection_iq_disco_cb (connection.c:2518): got disco request for node http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.616765Z.616765: connection_iq_disco_cb: sending disco response: * 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#XtViuVkOlKOArsru2DTS3ZoGWc8=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://www.google.com/transport/p2p' * feature var='urn:xmpp:jingle:transports:ice-udp:1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.616983Z.616983: _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#XtViuVkOlKOArsru2DTS3ZoGWc8=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://www.google.com/transport/p2p' * feature var='urn:xmpp:jingle:transports:ice-udp:1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.617126Z.617126: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.617376Z.617376: gabble_roster_presence_cb: ignoring presence from ourselves on another resource: * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.617463Z.617463: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (1) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.617538Z.617538: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.617604Z.617604: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.617634Z.617634: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.617898Z.617898: construct_simple_presence_hash: called. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.618517Z.618517: caps_cache_get_one_uint: wocky-caps-cache.c:498: 'PRAGMA table_info(capabilities)' returned no results (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.618561Z.618561: caps_cache_check_version: wocky-caps-cache.c:240: opened new, empty database at :memory: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.619010Z.619010: wocky_caps_cache_lookup: wocky-caps-cache.c:576: caps cache miss: http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619064Z.619064: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8=, setting caps for 1 (test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619139Z.619139: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619173Z.619173: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619206Z.619206: gabble_presence_set_capabilities (presence.c:291): new serial 1, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619242Z.619242: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.619331Z.619331: emit_capabilities_update (presence-cache.c:1106): 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: http://www.google.com/transport/p2p Feature: urn:xmpp:jingle:transports:ice-udp:1 --end-- (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.624134Z.624134: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.624266Z.624266: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='1029607232' * query xmlns='jabber:iq:roster' * item jid='test1@localhost/test-send-file.py' subscription='both' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.624402Z.624402: validate_roster_item: item node has resource in jid, skipping: * item xmlns='jabber:iq:roster' jid='test1@localhost/test-send-file.py' subscription='both' (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.624494Z.624494: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.624525Z.624525: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.624676Z.624676: construct_simple_presence_hash: called. tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] 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] tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [CAN_ADD|CAN_REMOVE] removed : [] flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [CAN_ADD|CAN_REMOVE] removed : [] flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES] (telepathy-gabble:23436): tp-glib/contact-lists-DEBUG: 2011-01-26T13:50:53.626399Z.626399: tp_base_contact_list_set_list_received: Initial contacts: (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.626527Z.626527: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.626620Z.626620: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.626710Z.626710: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.626817Z.626817: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.626971Z.626971: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.629867Z.629867: gabble_connection_update_capabilities (connection.c:3138): enter (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.629929Z.629929: gabble_media_factory_add_caps (media-factory.c:1020): Client self media capabilities: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.629971Z.629971: gabble_ft_manager_represent_client (ft-manager.c:840): client self supports file transfer (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630017Z.630017: gabble_connection_update_capabilities (connection.c:3183): client self contributes: --begin-- Feature: http://jabber.org/protocol/si/profile/file-transfer Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630098Z.630098: gabble_connection_refresh_capabilities (connection.c:2328): incorporating caps for self: --begin-- Feature: http://jabber.org/protocol/si/profile/file-transfer Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630166Z.630166: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource Resource with serial 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630200Z.630200: gabble_presence_set_capabilities (presence.c:286): found resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630232Z.630232: gabble_presence_set_capabilities (presence.c:291): new serial 2, old 1, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630271Z.630271: gabble_presence_set_capabilities (presence.c:298): updating caps for resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.630408Z.630408: gabble_presence_cache_add_own_caps (presence-cache.c:2110): caching our own caps (http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c=) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.630482Z.630482: _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='hAAgDAA+9NydDmxqE9Isw/2NW5c=' ext='pmuc-v1 share-v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.630540Z.630540: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.665919Z.665919: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.666101Z.666101: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666217Z.666217: gabble_roster_presence_cb: ignoring presence from ourselves on another resource: * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666319Z.666319: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (1) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666394Z.666394: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.666528Z.666528: wocky_caps_cache_lookup: wocky-caps-cache.c:576: caps cache miss: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666585Z.666585: _process_caps_uri (presence-cache.c:1551): not enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666626Z.666626: disco_waiter_new (presence-cache.c:160): created waiter 0xbce560 for handle 1 with serial 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666664Z.666664: _process_caps_uri (presence-cache.c:1596): only 0 trust out of 5 possible thus far, sending disco for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666724Z.666724: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xbcf080 for test@localhost/test-send-file.py (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.666831Z.666831: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='test@localhost/test-send-file.py' id='9387666787' * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.666886Z.666886: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.666961Z.666961: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.674241Z.674241: gabble_server_tls_manager_foreach_channel (server-tls-manager.c:388): Foreach channel (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.676866Z.676866: _gabble_connection_connect (connection.c:2030): disabling SRV because "server" or "old-ssl" was specified or port was not 5222, will connect to localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.676976Z.676976: _gabble_connection_connect (connection.c:2049): require-encryption is False; flipping ignore_ssl_errors to True (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677052Z.677052: _gabble_connection_connect (connection.c:2089): Start connecting (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.677158Z.677158: connector_connect_async: wocky-connector.c:2313: host: localhost; port: 4242 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.677303Z.677303: tp_base_connection_change_status: was 4294967295, now 1, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.677336Z.677336: tp_base_connection_change_status: emitting status-changed to 1, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677381Z.677381: connection_status_changed_cb (im-factory.c:428): adding callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677419Z.677419: gabble_signal_connect_weak (util.c:966): connecting to 0xb45d00:item-found with context 0xbfc6e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677463Z.677463: gabble_signal_connect_weak (util.c:966): connecting to 0xb45d00:done with context 0xbefec0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677505Z.677505: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.677556Z.677556: connection_status_changed_cb (muc-factory.c:943): adding callbacks (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.678023Z.678023: tcp_host_connected: wocky-connector.c:937: HOST connection succeeded (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.678117Z.678117: xmpp_init: wocky-connector.c:1056: sending XMPP stream open to server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.678164Z.678164: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:298: Writing stream opening: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.678293Z.678293: xmpp_init_sent_cb: wocky-connector.c:1077: waiting for stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.679381Z.679381: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.679492Z.679492: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test@localhost/test-send-file.py' type='get' id='9387666787' from='test@localhost/test-send-file.py' * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c=' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.679613Z.679613: connection_iq_disco_cb (connection.c:2518): got disco request for node http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.679852Z.679852: connection_iq_disco_cb: sending disco response: * iq xmlns='jabber:client' type='result' to='test@localhost/test-send-file.py' id='9387666787' * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://jabber.org/protocol/si/profile/file-transfer' * feature var='http://google.com/xmpp/protocol/share/v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.679995Z.679995: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='result' to='test@localhost/test-send-file.py' id='9387666787' * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://jabber.org/protocol/si/profile/file-transfer' * feature var='http://google.com/xmpp/protocol/share/v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.680135Z.680135: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684135Z.684135: Parsing chunk: PLAIN (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684208Z.684208: _start_element_ns: wocky-xmpp-reader.c:436: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684243Z.684243: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: version = '1.0' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684277Z.684277: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: id = '655de6bfb5691476' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684360Z.684360: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.684415Z.684415: xmpp_init_recv_cb: wocky-connector.c:1110: TCP Connection Established: : received XMPP v1.0 stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684449Z.684449: xmpp_init_recv_cb: wocky-connector.c:1125: waiting for feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684522Z.684522: xmpp_features_cb: wocky-connector.c:1180: received feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684592Z.684592: sasl_request_auth: wocky-connector.c:1309: handing over control to SASL module (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684633Z.684633: wocky_auth_registry_start_auth_async_func: wocky-auth-registry.c:290: Choosing PLAIN as auth mechanism (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684687Z.684687: plain_initial_response: wocky-sasl-plain.c:165: Got username and password (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.684780Z.684780: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.684833Z.684833: Writing xml: AHRlc3QxAHBhc3M= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.685091Z.685091: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.685441Z.685441: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test@localhost/test-send-file.py' type='result' id='9387666787' from='test@localhost/test-send-file.py' * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): gabble-DEBUG: 2011-01-26T13:50:53.685600Z.685600: client_types_from_message (presence-cache.c:1201): Got type for 1: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.685689Z.685689: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.685720Z.685720: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.685903Z.685903: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.686245Z.686245: _caps_disco_cb (presence-cache.c:1384): trusting http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= 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: 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:23436): wocky-DEBUG: 2011-01-26T13:50:53.686337Z.686337: wocky_caps_cache_insert: wocky-caps-cache.c:758: caps cache insert: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.686460Z.686460: _write_node_tree: Serializing tree: * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.686606Z.686606: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.686817Z.686817: set_caps_for (presence-cache.c:1138): setting caps for 1 (thanks to 1 test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.686866Z.686866: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.686901Z.686901: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.686933Z.686933: gabble_presence_set_capabilities (presence.c:291): new serial 2, old 1, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.687166Z.687166: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.687230Z.687230: emit_capabilities_update (presence-cache.c:1106): Emitting caps update for handle 1 --added-- Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.687812Z.687812: disco_waiter_list_free (presence-cache.c:186): list 0xbd5840 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.687851Z.687851: disco_waiter_free (presence-cache.c:171): freeing waiter 0xbce560 for handle 1 with serial 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689531Z.689531: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689615Z.689615: _end_element_ns: Received stanza * success xmlns='urn:ietf:params:xml:ns:xmpp-sasl' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689735Z.689735: auth_succeeded: wocky-sasl-auth.c:246: Authentication succeeded (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689771Z.689771: sasl_auth_done: wocky-connector.c:1344: SASL complete (success) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689799Z.689799: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689940Z.689940: xmpp_init: wocky-connector.c:1056: sending XMPP stream open to server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.689983Z.689983: wocky_xmpp_writer_stream_open: wocky-xmpp-writer.c:298: Writing stream opening: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.690084Z.690084: xmpp_init_sent_cb: wocky-connector.c:1077: waiting for stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694126Z.694126: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694201Z.694201: _start_element_ns: wocky-xmpp-reader.c:436: Received stream opening: stream, prefix: stream, uri: http://etherx.jabber.org/streams (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694237Z.694237: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: version = '1.0' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694271Z.694271: _start_element_ns: wocky-xmpp-reader.c:449: Stream opening attribute: id = '7ef2c50b66a2e06' (prefix: , uri: ) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694356Z.694356: _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:23436): wocky-DEBUG: 2011-01-26T13:50:53.694412Z.694412: xmpp_init_recv_cb: wocky-connector.c:1110: Authentication Completed: : received XMPP v1.0 stream open from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694446Z.694446: xmpp_init_recv_cb: wocky-connector.c:1125: waiting for feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694518Z.694518: xmpp_features_cb: wocky-connector.c:1180: received feature stanza from server (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694592Z.694592: iq_bind_resource: wocky-connector.c:1844: sending bind iq set stanza (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694638Z.694638: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='28694558' * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind' * resource "Resource" (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694685Z.694685: Writing xml: Resource (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.694782Z.694782: iq_bind_resource_sent_cb: wocky-connector.c:1867: bind iq set stanza sent (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.701987Z.701987: Parsing chunk: test1@localhost/Resource (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.702092Z.702092: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='28694558' * bind xmlns='urn:ietf:params:xml:ns:xmpp-bind' * jid "test1@localhost/Resource" (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.702149Z.702149: iq_bind_resource_recv_cb: wocky-connector.c:1885: bind iq response stanza received (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.702215Z.702215: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='9890702177' * session xmlns='urn:ietf:params:xml:ns:xmpp-session' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.702272Z.702272: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.703463Z.703463: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.703548Z.703548: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='9890702177' * session xmlns='urn:ietf:params:xml:ns:xmpp-session' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.703605Z.703605: connector_connected (connection.c:1778): connected (jid: test1@localhost/Resource) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.703760Z.703760: wocky_ping_set_property: wocky-ping.c:87: updated ping interval to 30 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704059Z.704059: gabble_roster_porter_available_cb (roster.c:1746): adding callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704363Z.704363: connector_connected (connection.c:1840): Created self handle 1, our JID is test1@localhost/Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704443Z.704443: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource Resource with serial 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704477Z.704477: gabble_presence_set_capabilities (presence.c:286): found resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704509Z.704509: gabble_presence_set_capabilities (presence.c:291): new serial 1, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704545Z.704545: gabble_presence_set_capabilities (presence.c:298): updating caps for resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704592Z.704592: gabble_connection_refresh_capabilities (connection.c:2350): not emitting self-presence stanza: not connected yet (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704630Z.704630: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xc119c0 for localhost (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.704724Z.704724: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='localhost' id='178704690' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.704769Z.704769: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.704838Z.704838: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xc11a40 for test1@localhost (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.705020Z.705020: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='test1@localhost' id='63704894' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.705071Z.705071: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.706425Z.706425: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.706519Z.706519: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='localhost' type='result' id='178704690' from='localhost' * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.706593Z.706593: connection_disco_cb: got: * query xmlns='http://jabber.org/protocol/disco#info' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.706627Z.706627: connection_disco_cb (connection.c:2766): set features flags to 0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.706708Z.706708: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='60706682' * query xmlns='jabber:iq:privacy' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.706766Z.706766: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.708301Z.708301: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.708412Z.708412: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test1@localhost' type='result' id='63704894' from='test1@localhost' * query xmlns='http://jabber.org/protocol/disco#info' * identity category='pubsub' type='pep' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.708487Z.708487: bare_jid_disco_cb (connection.c:1657): Server advertises PEP support in our jid features (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.709968Z.709968: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.710086Z.710086: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='error' id='60706682' * query xmlns='jabber:iq:privacy' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.710174Z.710174: get_existing_privacy_lists_cb (conn-presence.c:1019): Error getting privacy lists: Unknown or invalid XMPP error (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.710363Z.710363: gabble_presence_cache_add_own_caps (presence-cache.c:2110): caching our own caps (http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8=) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.710439Z.710439: _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='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.710507Z.710507: Writing xml: (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.710637Z.710637: tp_base_connection_change_status: was 1, now 0, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.710670Z.710670: tp_base_connection_change_status: emitting status-changed to 0, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.710720Z.710720: connection_status_changed_cb (roster.c:1778): requesting roster (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.710806Z.710806: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='61710776' * query xmlns='jabber:iq:roster' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.710847Z.710847: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.710918Z.710918: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.710970Z.710970: take_stun_server (jingle-factory.c:239): Resolving fallback STUN server stun.telepathy.im:3478 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711062Z.711062: gabble_disco_conn_status_changed_cb (disco.c:921): connected, initiating service discovery on localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711103Z.711103: gabble_disco_request_with_timeout (disco.c:509): Creating disco request 0xc11b80 for localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711207Z.711207: gabble_vcard_manager_request (vcard-manager.c:1559): Created request 0xc10750 to retrieve <1>'s vCard (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711275Z.711275: request_send (vcard-manager.c:1493): Cache entry 0xc11c40 is my own, not setting @to (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711335Z.711335: gabble_request_pipeline_enqueue (request-pipeline.c:433): enqueued new request as item 0xc12070 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711369Z.711369: gabble_request_pipeline_enqueue (request-pipeline.c:434): number of items in flight: 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.711405Z.711405: request_send (vcard-manager.c:1514): adding request to cache entry 0xc11c40 and queueing the (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.711462Z.711462: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.711491Z.711491: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.711773Z.711773: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.712050Z.712050: sidecars_conn_status_changed_cb (conn-sidecars.c:322): connected; requesting sidecars from plugins (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712252Z.712252: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' to='localhost' id='187711157' * query xmlns='http://jabber.org/protocol/disco#items' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712301Z.712301: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.712387Z.712387: stun_server_resolved_cb (jingle-factory.c:194): Resolved STUN server stun.telepathy.im:3478 to 6.7.8.9:3478 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712474Z.712474: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='1060711967' * pubsub xmlns='http://jabber.org/protocol/pubsub' * publish node='http://laptop.org/xmpp/activities' * item * activities xmlns='http://laptop.org/xmpp/activities' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712529Z.712529: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712636Z.712636: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' id='1049712017' * 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:23436): wocky-DEBUG: 2011-01-26T13:50:53.712692Z.712692: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.712814Z.712814: gabble_request_pipeline_go (request-pipeline.c:390): called; 1 pending items, 0 items in flight (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.712855Z.712855: send_next_request (request-pipeline.c:361): processing request 0xc12070 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712913Z.712913: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='8381712886' * vCard xmlns='vcard-temp' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.712954Z.712954: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.716503Z.716503: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.716676Z.716676: _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#XtViuVkOlKOArsru2DTS3ZoGWc8=' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.716777Z.716777: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' hash='sha-1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.716880Z.716880: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.716993Z.716993: connection_iq_disco_cb (connection.c:2518): got disco request for node http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.717197Z.717197: connection_iq_disco_cb: sending disco response: * 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#XtViuVkOlKOArsru2DTS3ZoGWc8=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://www.google.com/transport/p2p' * feature var='urn:xmpp:jingle:transports:ice-udp:1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.717340Z.717340: _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#XtViuVkOlKOArsru2DTS3ZoGWc8=' * identity category='client' name='Telepathy Gabble 0.11.5.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='http://www.google.com/transport/p2p' * feature var='urn:xmpp:jingle:transports:ice-udp:1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.717470Z.717470: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.717715Z.717715: gabble_roster_presence_cb: ignoring presence from ourselves on another resource: * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.717794Z.717794: gabble_presence_cache_do_update (presence-cache.c:1996): test1@localhost (1) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.717872Z.717872: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.717934Z.717934: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.717964Z.717964: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.718234Z.718234: construct_simple_presence_hash: called. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.718508Z.718508: wocky_caps_cache_lookup: wocky-caps-cache.c:576: caps cache miss: http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718559Z.718559: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8=, setting caps for 1 (test1@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718604Z.718604: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718638Z.718638: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718670Z.718670: gabble_presence_set_capabilities (presence.c:291): new serial 1, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718706Z.718706: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.718783Z.718783: emit_capabilities_update (presence-cache.c:1106): 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: http://www.google.com/transport/p2p Feature: urn:xmpp:jingle:transports:ice-udp:1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.719403Z.719403: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.719475Z.719475: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.719526Z.719526: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.719556Z.719556: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.719817Z.719817: construct_simple_presence_hash: called. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.720128Z.720128: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.720181Z.720181: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.720417Z.720417: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.720504Z.720504: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720641Z.720641: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 2 (test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720689Z.720689: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720737Z.720737: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720770Z.720770: gabble_presence_set_capabilities (presence.c:291): new serial 2, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720806Z.720806: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.720860Z.720860: client_types_from_message (presence-cache.c:1201): Got type for 2: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.720912Z.720912: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.720941Z.720941: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.721152Z.721152: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.721486Z.721486: emit_capabilities_update (presence-cache.c:1106): 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: 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:23436): wocky-DEBUG: 2011-01-26T13:50:53.722167Z.722167: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.722282Z.722282: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='XtViuVkOlKOArsru2DTS3ZoGWc8=' ext='pmuc-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.722397Z.722397: gabble_presence_cache_do_update (presence-cache.c:1996): test1@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.722465Z.722465: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.722515Z.722515: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.722544Z.722544: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.722752Z.722752: construct_simple_presence_hash: called. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.722972Z.722972: wocky_caps_cache_lookup: wocky-caps-cache.c:576: caps cache miss: http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8= (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723021Z.723021: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#XtViuVkOlKOArsru2DTS3ZoGWc8=, setting caps for 2 (test1@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723065Z.723065: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 3 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723112Z.723112: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723145Z.723145: gabble_presence_set_capabilities (presence.c:291): new serial 3, old 0, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723180Z.723180: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.723256Z.723256: emit_capabilities_update (presence-cache.c:1106): 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: http://www.google.com/transport/p2p Feature: urn:xmpp:jingle:transports:ice-udp:1 --end-- (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.726212Z.726212: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.726313Z.726313: _end_element_ns: Received stanza * iq xmlns='jabber:client' type='result' id='61710776' * query xmlns='jabber:iq:roster' * item jid='test@localhost/test-send-file.py' subscription='both' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.726437Z.726437: validate_roster_item: item node has resource in jid, skipping: * item xmlns='jabber:iq:roster' jid='test@localhost/test-send-file.py' subscription='both' (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.726484Z.726484: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.726512Z.726512: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.726648Z.726648: construct_simple_presence_hash: called. tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] 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] tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [CAN_ADD|CAN_REMOVE] removed : [] flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [PROPERTIES] removed : [] flags now: [PROPERTIES] tp_group_mixin_change_flags: emitting group flags changed added : [CAN_ADD|CAN_REMOVE] removed : [] flags now: [CAN_ADD|CAN_REMOVE|PROPERTIES] (telepathy-gabble:23436): tp-glib/contact-lists-DEBUG: 2011-01-26T13:50:53.727637Z.727637: tp_base_contact_list_set_list_received: Initial contacts: (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.727739Z.727739: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.727828Z.727828: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.727928Z.727928: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.728022Z.728022: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): tp-glib/groups-DEBUG: 2011-01-26T13:50:53.728108Z.728108: change_members: not emitting signal, nothing changed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734011Z.734011: gabble_connection_update_capabilities (connection.c:3138): enter (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734089Z.734089: gabble_media_factory_add_caps (media-factory.c:1020): Client self media capabilities: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734127Z.734127: gabble_ft_manager_represent_client (ft-manager.c:840): client self supports file transfer (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734172Z.734172: gabble_connection_update_capabilities (connection.c:3183): client self contributes: --begin-- Feature: http://jabber.org/protocol/si/profile/file-transfer Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734248Z.734248: gabble_connection_refresh_capabilities (connection.c:2328): incorporating caps for self: --begin-- Feature: http://jabber.org/protocol/si/profile/file-transfer Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734306Z.734306: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource Resource with serial 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734339Z.734339: gabble_presence_set_capabilities (presence.c:286): found resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734370Z.734370: gabble_presence_set_capabilities (presence.c:291): new serial 2, old 1, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734408Z.734408: gabble_presence_set_capabilities (presence.c:298): updating caps for resource Resource (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.734537Z.734537: gabble_presence_cache_add_own_caps (presence-cache.c:2110): caching our own caps (http://telepathy.freedesktop.org/caps#hAAgDAA+9NydDmxqE9Isw/2NW5c=) (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.734609Z.734609: _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='hAAgDAA+9NydDmxqE9Isw/2NW5c=' ext='pmuc-v1 share-v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.734665Z.734665: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.766782Z.766782: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.766978Z.766978: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.767083Z.767083: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.767211Z.767211: gabble_roster_presence_cb: ignoring presence from ourselves on another resource: * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.767289Z.767289: gabble_presence_cache_do_update (presence-cache.c:1996): test1@localhost (1) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.767369Z.767369: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.767506Z.767506: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.767551Z.767551: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.767795Z.767795: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.767897Z.767897: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768035Z.768035: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 1 (test1@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768084Z.768084: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 3 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768131Z.768131: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768164Z.768164: gabble_presence_set_capabilities (presence.c:291): new serial 3, old 1, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768216Z.768216: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768266Z.768266: client_types_from_message (presence-cache.c:1201): Got type for 1: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.768329Z.768329: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.768359Z.768359: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.768540Z.768540: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.768946Z.768946: emit_capabilities_update (presence-cache.c:1106): Emitting caps update for handle 1 --added-- Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.769644Z.769644: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.769714Z.769714: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.769807Z.769807: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.769846Z.769846: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.770068Z.770068: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.770167Z.770167: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770294Z.770294: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 2 (test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770358Z.770358: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 4 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770392Z.770392: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770425Z.770425: gabble_presence_set_capabilities (presence.c:291): new serial 4, old 2, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770463Z.770463: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.770511Z.770511: client_types_from_message (presence-cache.c:1201): Got type for 2: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.770562Z.770562: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.770591Z.770591: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.770809Z.770809: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.771254Z.771254: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.771611Z.771611: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.771727Z.771727: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.771836Z.771836: gabble_presence_cache_do_update (presence-cache.c:1996): test1@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.771900Z.771900: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.771995Z.771995: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.772034Z.772034: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.772269Z.772269: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.772363Z.772363: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772483Z.772483: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 2 (test1@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772533Z.772533: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 4 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772566Z.772566: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772598Z.772598: gabble_presence_set_capabilities (presence.c:291): new serial 4, old 3, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772637Z.772637: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.772684Z.772684: client_types_from_message (presence-cache.c:1201): Got type for 2: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.772742Z.772742: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.772772Z.772772: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.772987Z.772987: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.773298Z.773298: emit_capabilities_update (presence-cache.c:1106): Emitting caps update for handle 2 --added-- Feature: http://google.com/xmpp/protocol/share/v1 --end-- (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.804979Z.804979: channel_request_new: New channel request at 0xc28c90: ctype=org.freedesktop.Telepathy.Channel.Type.FileTransfer htype=1 handle=2 suppress=1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805075Z.805075: gabble_ft_manager_handle_request (ft-manager.c:451): File transfer request (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805124Z.805124: gabble_ft_manager_handle_request (ft-manager.c:550): Requested outgoing channel with contact: test1@localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805751Z.805751: gabble_signal_connect_weak (util.c:966): connecting to 0xb4ca10:presences-updated with context 0xc26a20 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805802Z.805802: gabble_file_transfer_channel_constructor (ft-channel.c:528): New FT channel created: /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/FileTransferChannel/0xb5a4d0 (contact: test1@localhost, initiator: test@localhost, file: "The greek foo ??????.txt", size: 16) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805941Z.805941: offer_gtalk_file_transfer (ft-channel.c:1358): Offering Gtalk file transfer to test1@localhost/test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.805994Z.805994: gtalk_file_collection_init (gtalk-file-collection.c:214): GTalk file collection init called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806237Z.806237: gabble_jingle_session_init (jingle-session.c:191): Initializing the jingle session 0xb4c860 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806333Z.806333: create_session (jingle-factory.c:873): new session (test1@localhost/test-send-file.py, 2002060819) @ 0xb4c860 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806386Z.806386: create_content (jingle-session.c:806): session creating new content name share, type 0, conn 0xb7e0a0, jf 0xb54220 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806526Z.806526: gabble_jingle_content_init (jingle-content.c:115): 0xb590c0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806560Z.806560: gabble_jingle_share_init (jingle-share.c:156): jingle share init called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806722Z.806722: create_content (jingle-session.c:845): inserting content share into initiator_contents (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806779Z.806779: _gabble_jingle_content_set_media_ready (jingle-content.c:1088): media ready on content: share created_by_us: 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806825Z.806825: content_ready_cb (jingle-session.c:2289): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806857Z.806857: try_session_initiate_or_accept (jingle-session.c:1880): Trying initiate or accept (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806891Z.806891: try_session_initiate_or_accept (jingle-session.c:1896): session not locally accepted yet, not initiating (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806938Z.806938: gabble_signal_connect_weak (util.c:966): connecting to 0xb4c860:notify::state with context 0xc2b8e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.806998Z.806998: gabble_signal_connect_weak (util.c:966): connecting to 0xb4c860:terminated with context 0xbea2a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807041Z.807041: gabble_signal_connect_weak (util.c:966): connecting to 0xb590c0:new-share-channel with context 0xc2bc00 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807083Z.807083: gabble_signal_connect_weak (util.c:966): connecting to 0xb590c0:completed with context 0xc2bd80 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807128Z.807128: try_session_initiate_or_accept (jingle-session.c:1880): Trying initiate or accept (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.807273Z.807273: _write_node_tree: Serializing tree: * presence xmlns='jabber:client' to='test1@localhost' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' hash='sha-1' node='http://telepathy.freedesktop.org/caps' ver='hAAgDAA+9NydDmxqE9Isw/2NW5c=' ext='pmuc-v1 share-v1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.807345Z.807345: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807410Z.807410: try_session_initiate_or_accept (jingle-session.c:1931): Contents are ready: yes (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807477Z.807477: produce_description (jingle-share.c:461): produce description called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807688Z.807688: set_state (jingle-session.c:2014): Setting state of JingleSession: 0xb4c860 (priv = 0xb4c890) from 0 to 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807747Z.807747: jingle_session_state_changed_cb (gtalk-file-collection.c:422): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807785Z.807785: gabble_file_transfer_channel_gtalk_file_collection_state_changed (ft-channel.c:1295): gtalk ft state changed to 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.807846Z.807846: gabble_signal_connect_weak (util.c:966): connecting to 0xb5a4d0:closed with context 0xc326a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.807904Z.807904: satisfy_request: completing queued request 0xc28c90 with success, channel_type=org.freedesktop.Telepathy.Channel.Type.FileTransfer, handle_type=1, handle=2, suppress_handler=1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:50:53.808322Z.808322: channel_request_free: Freeing channel request at 0xc28c90: ctype=org.freedesktop.Telepathy.Channel.Type.FileTransfer htype=1 handle=2 suppress=1 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.809278Z.809278: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' to='test1@localhost/test-send-file.py' id='680807647' * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' id='2002060819' type='initiate' * description xmlns='http://www.google.com/session/share' * manifest * file size='16' * name "The greek foo ??????.txt" * protocol * http * url name='source-path' "/temporary/6f0f836a-518b-4947-8f88-7bb6b846f7fb/" * url name='preview-path' "/temporary/3fac543a-26af-4f91-8a5c-af49ae336b72/" * transport xmlns='http://www.google.com/transport/p2p' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.809433Z.809433: Writing xml: The greek foo ??????.txt/temporary/6f0f836a-518b-4947-8f88-7bb6b846f7fb//temporary/3fac543a-26af-4f91-8a5c-af49ae336b72/ (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.857006Z.857006: Parsing chunk: The greek foo ??????.txt/temporary/6f0f836a-518b-4947-8f88-7bb6b846f7fb//temporary/3fac543a-26af-4f91-8a5c-af49ae336b72/ (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.857261Z.857261: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.857447Z.857447: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test1@localhost/test-send-file.py' type='set' id='680807647' from='test@localhost/test-send-file.py' * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='initiate' id='2002060819' * description xmlns='http://www.google.com/session/share' * manifest * file size='16' * name "The greek foo ??????.txt" * protocol * http * url name='source-path' "/temporary/6f0f836a-518b-4947-8f88-7bb6b846f7fb/" * url name='preview-path' "/temporary/3fac543a-26af-4f91-8a5c-af49ae336b72/" * transport xmlns='http://www.google.com/transport/p2p' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.857786Z.857786: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.857861Z.857861: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.857997Z.857997: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.858037Z.858037: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.858283Z.858283: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.858365Z.858365: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858502Z.858502: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 2 (test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858551Z.858551: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 5 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858585Z.858585: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858617Z.858617: gabble_presence_set_capabilities (presence.c:291): new serial 5, old 4, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858669Z.858669: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.858717Z.858717: client_types_from_message (presence-cache.c:1201): Got type for 2: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.858782Z.858782: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.858812Z.858812: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.859002Z.859002: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859211Z.859211: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859412Z.859412: gabble_jingle_session_init (jingle-session.c:191): Initializing the jingle session 0xb4cf20 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859500Z.859500: create_session (jingle-factory.c:873): new session (test@localhost/test-send-file.py, 2002060819) @ 0xb4cf20 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859550Z.859550: gabble_jingle_session_parse (jingle-session.c:1600): jingle action 'initiate' from 'test@localhost/test-send-file.py' in session '2002060819' dialect 2 state 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859589Z.859589: _each_content_add (jingle-session.c:879): namespace: http://www.google.com/session/share (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859625Z.859625: create_content (jingle-session.c:806): session creating new content name (null), type 0, conn 0xb7e3e0, jf 0xb544a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859713Z.859713: gabble_jingle_content_init (jingle-content.c:115): 0xb59180 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859752Z.859752: gabble_jingle_share_init (jingle-share.c:156): jingle share init called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859838Z.859838: parse_description (jingle-share.c:303): parse description called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859894Z.859894: _gabble_jingle_content_set_media_ready (jingle-content.c:1088): media ready on content: gtalk created_by_us: 0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.859937Z.859937: gabble_jingle_content_parse_add (jingle-content.c:606): content creating new transport type GabbleJingleTransportGoogle (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860010Z.860010: parse_candidates (jingle-transport-google.c:379): emitting 0 new remote candidates (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860064Z.860064: create_content (jingle-session.c:845): inserting content gtalk into initiator_contents (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860122Z.860122: set_state (jingle-session.c:2014): Setting state of JingleSession: 0xb4cf20 (priv = 0xb4cf50) from 0 to 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860170Z.860170: gabble_jingle_session_send_rtp_info (jingle-session.c:2309): Not sending ; not using modern Jingle (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860228Z.860228: gtalk_file_collection_init (gtalk-file-collection.c:214): GTalk file collection init called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860279Z.860279: gabble_signal_connect_weak (util.c:966): connecting to 0xb4cf20:notify::state with context 0xc327a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860327Z.860327: gabble_signal_connect_weak (util.c:966): connecting to 0xb4cf20:terminated with context 0xc38380 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860449Z.860449: gabble_signal_connect_weak (util.c:966): connecting to 0xb59180:new-share-channel with context 0xc384a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860499Z.860499: gabble_signal_connect_weak (util.c:966): connecting to 0xb59180:completed with context 0xc38580 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860744Z.860744: gabble_signal_connect_weak (util.c:966): connecting to 0xb4caa0:presences-updated with context 0xc38360 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860798Z.860798: gabble_file_transfer_channel_constructor (ft-channel.c:528): New FT channel created: /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource/FileTransferChannel/0xb5a3e0 (contact: test@localhost, initiator: test@localhost, file: "The greek foo ??????.txt", size: 16) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.860909Z.860909: gabble_signal_connect_weak (util.c:966): connecting to 0xb5a3e0:closed with context 0xc34d60 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.861869Z.861869: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='result' to='test@localhost/test-send-file.py' id='680807647' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.862034Z.862034: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.862277Z.862277: send_gtalk4_transport_accept (jingle-content.c:490): Sending Gtalk4 'transport-accept' message to peer (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.862356Z.862356: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' to='test@localhost/test-send-file.py' id='8242862314' * session xmlns='http://www.google.com/session' initiator='test@localhost/test-send-file.py' id='2002060819' type='transport-accept' * transport xmlns='http://www.google.com/transport/p2p' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.862413Z.862413: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.864889Z.864889: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.865070Z.865070: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test1@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.865175Z.865175: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.865290Z.865290: gabble_presence_cache_do_update (presence-cache.c:1996): test1@localhost (2) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.865360Z.865360: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.865484Z.865484: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.865550Z.865550: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.865782Z.865782: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.865869Z.865869: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866002Z.866002: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 2 (test1@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866052Z.866052: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 5 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866086Z.866086: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866139Z.866139: gabble_presence_set_capabilities (presence.c:291): new serial 5, old 4, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866178Z.866178: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866228Z.866228: client_types_from_message (presence-cache.c:1201): Got type for 2: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.866286Z.866286: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.866317Z.866317: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.866559Z.866559: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.866863Z.866863: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867016Z.867016: gabble_roster_presence_cb: ignoring presence from ourselves on another resource: * presence xmlns='jabber:client' to='test@localhost/test-send-file.py' from='test@localhost/test-send-file.py' * x xmlns='vcard-temp:x:update' * c xmlns='http://jabber.org/protocol/caps' node='http://telepathy.freedesktop.org/caps' ver='sQOIaEbliDrJ95JbdffkEFyKo0s=' ext='pmuc-v1 share-v1' hash='sha-1' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867091Z.867091: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (1) resource test-send-file.py prio 0 presence 7 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867155Z.867155: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.867247Z.867247: wocky_caps_cache_lookup: wocky-caps-cache.c:589: caps cache hit: http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s= (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.867286Z.867286: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.867510Z.867510: _end_element_ns: Received stanza * query xmlns='http://jabber.org/protocol/disco#info' node='http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=' * identity category='client' type='pc' name='Telepathy Gabble 0.11.5.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='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:23436): wocky-DEBUG: 2011-01-26T13:50:53.867594Z.867594: wocky_xmpp_reader_reset: wocky-xmpp-reader.c:752: Resetting the xmpp reader (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867784Z.867784: _process_caps_uri (presence-cache.c:1511): enough trust for URI http://telepathy.freedesktop.org/caps#sQOIaEbliDrJ95JbdffkEFyKo0s=, setting caps for 1 (test@localhost/test-send-file.py) (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867834Z.867834: gabble_presence_set_capabilities (presence.c:278): about to add caps to resource test-send-file.py with serial 6 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867869Z.867869: gabble_presence_set_capabilities (presence.c:286): found resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867901Z.867901: gabble_presence_set_capabilities (presence.c:291): new serial 6, old 2, clearing caps (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.867954Z.867954: gabble_presence_set_capabilities (presence.c:298): updating caps for resource test-send-file.py (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.868002Z.868002: client_types_from_message (presence-cache.c:1201): Got type for 1: pc (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.868053Z.868053: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.868082Z.868082: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:50:53.868332Z.868332: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.868634Z.868634: emit_capabilities_update (presence-cache.c:1097): no change in caps for handle 1 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.899833Z.899833: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.899986Z.899986: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test@localhost/test-send-file.py' type='result' id='680807647' from='test1@localhost/test-send-file.py' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.900072Z.900072: set_state (jingle-session.c:2014): Setting state of JingleSession: 0xb4c860 (priv = 0xb4c890) from 1 to 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.900138Z.900138: jingle_session_state_changed_cb (gtalk-file-collection.c:422): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.900179Z.900179: gabble_file_transfer_channel_gtalk_file_collection_state_changed (ft-channel.c:1295): gtalk ft state changed to 0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.902720Z.902720: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.902868Z.902868: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test@localhost/test-send-file.py' type='set' id='8242862314' from='test1@localhost/test-send-file.py' * session xmlns='http://www.google.com/session' initiator='test@localhost/test-send-file.py' type='transport-accept' id='2002060819' * transport xmlns='http://www.google.com/transport/p2p' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.903005Z.903005: gabble_jingle_session_parse (jingle-session.c:1600): jingle action 'transport-accept' from 'test1@localhost/test-send-file.py' in session '2002060819' dialect 2 state 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:53.903053Z.903053: on_transport_accept (jingle-session.c:1429): Ignoring 'transport-accept' action from peer (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.903137Z.903137: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='result' to='test1@localhost/test-send-file.py' id='8242862314' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.903186Z.903186: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.904963Z.904963: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:50:53.905063Z.905063: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test1@localhost/test-send-file.py' type='result' id='8242862314' from='test@localhost/test-send-file.py' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:56.629983Z.629983: timeout_request (vcard-manager.c:787): Request 0xbcdf20 timed out, notifying callback 0x476cb0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:56.630177Z.630177: pipeline_reply_cb (vcard-manager.c:1344): called for entry 0xbcb2c0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:56.630322Z.630322: delete_request (vcard-manager.c:751): Discarding request 0xbcdf20 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:56.630429Z.630429: gabble_request_pipeline_go (request-pipeline.c:390): called; 0 pending items, 0 items in flight (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:57.629040Z.629040: timeout_request (vcard-manager.c:787): Request 0xc10750 timed out, notifying callback 0x476cb0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:57.629132Z.629132: pipeline_reply_cb (vcard-manager.c:1344): called for entry 0xc11c40 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:57.629172Z.629172: delete_request (vcard-manager.c:751): Discarding request 0xc10750 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:57.629215Z.629215: gabble_request_pipeline_go (request-pipeline.c:390): called; 0 pending items, 0 items in flight (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:58.629029Z.629029: gabble_presence_cache_end_unsure_period (presence-cache.c:427): 0xb4ca10 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:50:59.629318Z.629318: gabble_presence_cache_end_unsure_period (presence-cache.c:427): 0xb4caa0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.908599Z.908599: tp_base_connection_change_status: was 0, now 2, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.908741Z.908741: tp_base_connection_change_status: emitting status-changed to 2, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909337Z.909337: gabble_roster_close_all (roster.c:1672): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909469Z.909469: gabble_roster_close_all (roster.c:1700): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909593Z.909593: gabble_im_factory_close_all (im-factory.c:410): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909691Z.909691: connection_status_changed_cb (roomlist-manager.c:193): disconnected, closing room lists (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909766Z.909766: gabble_roomlist_manager_close_all (roomlist-manager.c:87): 0xb45ac0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909846Z.909846: gabble_search_manager_close_all (search-manager.c:98): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.909931Z.909931: gabble_auth_manager_close_all (auth-manager.c:89): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910006Z.910006: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910086Z.910086: gabble_muc_factory_close_all (muc-factory.c:885): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910174Z.910174: gabble_muc_factory_close_all (muc-factory.c:922): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910264Z.910264: gabble_private_tubes_factory_close_all (private-tubes-factory.c:358): closing 1-1 tubes channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910394Z.910394: gabble_media_factory_close_all (media-factory.c:428): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910477Z.910477: gabble_file_transfer_channel_do_close (ft-channel.c:171): Emitting closed signal for /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/FileTransferChannel/0xb5a4d0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910653Z.910653: file_channel_closed_cb (ft-manager.c:281): Removing channel /org/freedesktop/Telepathy/Connection/gabble/jabber/test_40localhost_2fResource/FileTransferChannel/0xb5a4d0 with test1@localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910751Z.910751: gabble_file_transfer_channel_dispose (ft-channel.c:829): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.910875Z.910875: close_session_and_transport (ft-channel.c:895): Closing session and transport (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.911228Z.911228: gtalk_file_collection_terminate (gtalk-file-collection.c:1709): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.911320Z.911320: gabble_file_transfer_channel_gtalk_file_collection_state_changed (ft-channel.c:1295): gtalk ft state changed to 3 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.911498Z.911498: close_session_and_transport (ft-channel.c:895): Closing session and transport (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.911576Z.911576: gtalk_file_collection_terminate (gtalk-file-collection.c:1709): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.911648Z.911648: gtalk_file_collection_dispose (gtalk-file-collection.c:248): dispose called (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.911933Z.911933: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='set' to='test1@localhost/test-send-file.py' id='8400911831' * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' id='2002060819' type='terminate' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.912061Z.912061: Writing xml: (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.912578Z.912578: gabble_jingle_session_terminate (jingle-session.c:2096): we are terminating this session (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.912661Z.912661: set_state (jingle-session.c:2014): Setting state of JingleSession: 0xb4c860 (priv = 0xb4c890) from 2 to 5 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.912771Z.912771: jingle_session_state_changed_cb (gtalk-file-collection.c:422): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.912958Z.912958: session_terminated_cb (jingle-factory.c:939): removing terminated session with key 2 test1@localhost/test-send-file.py 2002060819 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913058Z.913058: gabble_jingle_session_dispose (jingle-session.c:215): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913152Z.913152: gabble_jingle_share_dispose (jingle-share.c:172): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913245Z.913245: gabble_jingle_content_dispose (jingle-content.c:137): 0xb590c0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913332Z.913332: instance_destroyed_cb (util.c:922): instance for 0xc2bc00 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913410Z.913410: instance_destroyed_cb (util.c:922): instance for 0xc2bd80 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913507Z.913507: instance_destroyed_cb (util.c:922): instance for 0xc2b8e0 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913580Z.913580: instance_destroyed_cb (util.c:922): instance for 0xbea2a0 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913704Z.913704: user_data_destroyed_cb (util.c:935): user_data for 0xc26a20 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.913788Z.913788: instance_destroyed_cb (util.c:922): instance for 0xc326a0 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.914274Z.914274: connection_shut_down (connection.c:2169): connection may still be open; closing it: 0xb7e0a0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.914441Z.914441: wocky_porter_close_async: wocky-porter.c:1431: Sending queue is not empty. Flushing it before closing the connection. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.915189Z.915189: send_stanza_cb: wocky-porter.c:757: Queue has been flushed. Closing the connection. (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.915316Z.915316: wocky_xmpp_writer_stream_close: wocky-xmpp-writer.c:325: Writing stream close: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.917592Z.917592: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.917852Z.917852: _end_element_ns: Received stanza * iq xmlns='jabber:client' to='test1@localhost/test-send-file.py' type='set' id='8400911831' from='test@localhost/test-send-file.py' * session xmlns='http://www.google.com/session' initiator='test@localhost/Resource' type='terminate' id='2002060819' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918119Z.918119: gabble_jingle_session_parse (jingle-session.c:1600): jingle action 'terminate' from 'test@localhost/test-send-file.py' in session '2002060819' dialect 2 state 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918215Z.918215: on_session_terminate (jingle-session.c:1331): remote end terminated the session with reason unknown and text '(none)' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918295Z.918295: set_state (jingle-session.c:2014): Setting state of JingleSession: 0xb4cf20 (priv = 0xb4cf50) from 2 to 5 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918402Z.918402: jingle_session_state_changed_cb (gtalk-file-collection.c:422): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918510Z.918510: session_terminated_cb (jingle-factory.c:939): removing terminated session with key 2 test@localhost/test-send-file.py 2002060819 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.918600Z.918600: gabble_file_transfer_channel_gtalk_file_collection_state_changed (ft-channel.c:1295): gtalk ft state changed to 3 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919023Z.919023: close_session_and_transport (ft-channel.c:895): Closing session and transport (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919107Z.919107: gtalk_file_collection_terminate (gtalk-file-collection.c:1709): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919188Z.919188: gabble_file_transfer_channel_gtalk_file_collection_state_changed (ft-channel.c:1295): gtalk ft state changed to 3 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919264Z.919264: close_session_and_transport (ft-channel.c:895): Closing session and transport (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919334Z.919334: gtalk_file_collection_terminate (gtalk-file-collection.c:1709): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919405Z.919405: gtalk_file_collection_dispose (gtalk-file-collection.c:248): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919478Z.919478: gabble_jingle_session_terminate (jingle-session.c:2062): session already terminated, ignoring terminate request (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919567Z.919567: user_data_destroyed_cb (util.c:935): user_data for 0xc327a0 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919650Z.919650: user_data_destroyed_cb (util.c:935): user_data for 0xc38380 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919727Z.919727: user_data_destroyed_cb (util.c:935): user_data for 0xc384a0 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919806Z.919806: user_data_destroyed_cb (util.c:935): user_data for 0xc38580 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919903Z.919903: gabble_jingle_session_dispose (jingle-session.c:215): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919936Z.919936: gabble_jingle_share_dispose (jingle-share.c:172): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.919984Z.919984: gabble_jingle_content_dispose (jingle-content.c:137): 0xb59180 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.920070Z.920070: _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='result' to='test@localhost/test-send-file.py' id='8400911831' (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.920123Z.920123: Writing xml: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.920219Z.920219: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.920249Z.920249: _end_element_ns: wocky-xmpp-reader.c:579: Stream ended (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.920284Z.920284: stanza_received_cb: wocky-porter.c:1217: Remote connection has been closed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920353Z.920353: closed_cb (connection.c:2135): connection properly closed (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:51:08.920405Z.920405: connection_shutdown_finished_cb: dereferenced connection (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920462Z.920462: gabble_connection_dispose (connection.c:1124): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920493Z.920493: gabble_bytestream_factory_dispose (bytestream-factory.c:663): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920556Z.920556: user_data_destroyed_cb (util.c:935): user_data for 0xb89e20 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920594Z.920594: user_data_destroyed_cb (util.c:935): user_data for 0xb89b00 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920632Z.920632: gabble_disco_dispose (disco.c:229): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920666Z.920666: disco_items_cb (disco.c:741): Got error on items request: Request for items on localhost cancelled (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920710Z.920710: disco_done_cb (search-manager.c:135): Disco is done; complete pending requests (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920767Z.920767: instance_destroyed_cb (util.c:922): instance for 0xba9600 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920801Z.920801: instance_destroyed_cb (util.c:922): instance for 0xb89d60 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920836Z.920836: gabble_disco_finalize (disco.c:256): called with 0xb45b40 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920871Z.920871: gabble_request_pipeline_dispose (request-pipeline.c:275): disposing request-pipeline (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920899Z.920899: delete_item (request-pipeline.c:178): deleting item 0xbcdf80 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920957Z.920957: gabble_vcard_manager_dispose (vcard-manager.c:576): 0xb79110 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.920998Z.920998: gabble_vcard_manager_finalize (vcard-manager.c:607): 0xb79110 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921026Z.921026: gabble_jingle_factory_dispose (jingle-factory.c:485): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921068Z.921068: user_data_destroyed_cb (util.c:935): user_data for 0xb7c420 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921126Z.921126: gabble_presence_cache_dispose (presence-cache.c:538): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921311Z.921311: gabble_presence_cache_finalize (presence-cache.c:569): called with 0xb4ca10 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921456Z.921456: gabble_roster_dispose (roster.c:201): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921486Z.921486: gabble_roster_close_all (roster.c:1672): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921535Z.921535: gabble_roster_finalize (roster.c:233): called with 0xb5a110 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921569Z.921569: gabble_im_factory_dispose (im-factory.c:125): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921603Z.921603: gabble_roomlist_manager_dispose (roomlist-manager.c:129): running (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921630Z.921630: gabble_roomlist_manager_close_all (roomlist-manager.c:87): 0xb45ac0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921664Z.921664: gabble_search_manager_dispose (search-manager.c:212): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921694Z.921694: gabble_search_manager_close_all (search-manager.c:98): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921729Z.921729: user_data_destroyed_cb (util.c:935): user_data for 0xb7c680 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921766Z.921766: gabble_auth_manager_dispose (auth-manager.c:158): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921794Z.921794: gabble_auth_manager_close_all (auth-manager.c:89): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921832Z.921832: user_data_destroyed_cb (util.c:935): user_data for 0xb7cae0 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921867Z.921867: gabble_server_tls_manager_dispose (server-tls-manager.c:309): 0xb54180 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921902Z.921902: user_data_destroyed_cb (util.c:935): user_data for 0xb7c960 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921936Z.921936: gabble_server_tls_manager_finalize (server-tls-manager.c:326): 0xb54180 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921970Z.921970: gabble_muc_factory_dispose (muc-factory.c:158): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.921998Z.921998: gabble_muc_factory_close_all (muc-factory.c:885): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922035Z.922035: gabble_private_tubes_factory_dispose (private-tubes-factory.c:179): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922065Z.922065: gabble_private_tubes_factory_close_all (private-tubes-factory.c:358): closing 1-1 tubes channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922114Z.922114: gabble_media_factory_dispose (media-factory.c:164): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922143Z.922143: gabble_media_factory_close_all (media-factory.c:428): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922242Z.922242: gabble_connection_finalize (connection.c:1198): called with 0xb7e0a0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.922274Z.922274: tp_contacts_mixin_finalize: 0xb7e0a0 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:51:08.922306Z.922306: tp_presence_mixin_finalize: 0xb7e0a0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922336Z.922336: gabble_capabilities_finalize (capabilities.c:314): 0xb7e0a0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.922444Z.922444: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.922520Z.922520: _end_element_ns: Received stanza * presence xmlns='jabber:client' to='test1@localhost/test-send-file.py' from='test@localhost/test-send-file.py' type='unavailable' (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922618Z.922618: gabble_presence_cache_do_update (presence-cache.c:1996): test@localhost (2) resource test-send-file.py prio 0 presence 1 message "" (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.922727Z.922727: emit_capabilities_update (presence-cache.c:1106): 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: 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:23436): tp-glib/presence-DEBUG: 2011-01-26T13:51:08.923049Z.923049: tp_presence_mixin_emit_presence_update: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:51:08.923085Z.923085: construct_presence_hash: called. (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:51:08.923243Z.923243: construct_simple_presence_hash: called. (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.923511Z.923511: gabble_presence_cache_maybe_remove (presence-cache.c:1953): discarding cached presence for unavailable jid test@localhost ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.923614Z.923614: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.923665Z.923665: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.923708Z.923708: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.923750Z.923750: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.923794Z.923794: send_iq_async failed: Stream closed (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.923922Z.923922: wocky_porter_finalize: wocky-porter.c:638: finalize porter 0xb545e0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.925103Z.925103: tp_base_connection_change_status: was 0, now 2, for reason 1 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.925143Z.925143: tp_base_connection_change_status: emitting status-changed to 2, for reason 1 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925498Z.925498: gabble_roster_close_all (roster.c:1672): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925550Z.925550: gabble_roster_close_all (roster.c:1700): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925602Z.925602: gabble_im_factory_close_all (im-factory.c:410): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925645Z.925645: connection_status_changed_cb (roomlist-manager.c:193): disconnected, closing room lists (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925680Z.925680: gabble_roomlist_manager_close_all (roomlist-manager.c:87): 0xb45cc0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925717Z.925717: gabble_search_manager_close_all (search-manager.c:98): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925756Z.925756: gabble_auth_manager_close_all (auth-manager.c:89): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925789Z.925789: connection_status_changed_cb (server-tls-manager.c:120): Connection status changed, now 2 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925824Z.925824: gabble_muc_factory_close_all (muc-factory.c:885): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925861Z.925861: gabble_muc_factory_close_all (muc-factory.c:922): removing callbacks (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925902Z.925902: gabble_private_tubes_factory_close_all (private-tubes-factory.c:358): closing 1-1 tubes channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.925958Z.925958: gabble_media_factory_close_all (media-factory.c:428): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926011Z.926011: gabble_file_transfer_channel_do_close (ft-channel.c:171): Emitting closed signal for /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource/FileTransferChannel/0xb5a3e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926128Z.926128: file_channel_closed_cb (ft-manager.c:281): Removing channel /org/freedesktop/Telepathy/Connection/gabble/jabber/test1_40localhost_2fResource/FileTransferChannel/0xb5a3e0 with test@localhost (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926173Z.926173: gabble_file_transfer_channel_dispose (ft-channel.c:829): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926425Z.926425: close_session_and_transport (ft-channel.c:895): Closing session and transport (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926477Z.926477: user_data_destroyed_cb (util.c:935): user_data for 0xc38360 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926517Z.926517: instance_destroyed_cb (util.c:922): instance for 0xc34d60 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.926684Z.926684: connection_shut_down (connection.c:2169): connection may still be open; closing it: 0xb7e3e0 (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.926728Z.926728: wocky_xmpp_writer_stream_close: wocky-xmpp-writer.c:325: Writing stream close: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.962459Z.962459: Parsing chunk: (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.962566Z.962566: _end_element_ns: wocky-xmpp-reader.c:579: Stream ended (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.962654Z.962654: stanza_received_cb: wocky-porter.c:1217: Remote connection has been closed (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.962820Z.962820: closed_cb (connection.c:2135): connection properly closed (telepathy-gabble:23436): tp-glib/params-DEBUG: 2011-01-26T13:51:08.962954Z.962954: connection_shutdown_finished_cb: dereferenced connection (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963083Z.963083: gabble_connection_dispose (connection.c:1124): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963158Z.963158: gabble_bytestream_factory_dispose (bytestream-factory.c:663): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963300Z.963300: user_data_destroyed_cb (util.c:935): user_data for 0xb9f040 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963387Z.963387: user_data_destroyed_cb (util.c:935): user_data for 0xb9eea0 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963477Z.963477: gabble_disco_dispose (disco.c:229): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963552Z.963552: disco_items_cb (disco.c:741): Got error on items request: Request for items on localhost cancelled (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963646Z.963646: disco_done_cb (search-manager.c:135): Disco is done; complete pending requests (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963746Z.963746: instance_destroyed_cb (util.c:922): instance for 0xbfc6e0 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963825Z.963825: instance_destroyed_cb (util.c:922): instance for 0xbefec0 destroyed; cleaning up (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963904Z.963904: gabble_disco_finalize (disco.c:256): called with 0xb45d00 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.963978Z.963978: gabble_request_pipeline_dispose (request-pipeline.c:275): disposing request-pipeline (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964054Z.964054: delete_item (request-pipeline.c:178): deleting item 0xc12070 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964165Z.964165: gabble_vcard_manager_dispose (vcard-manager.c:576): 0xb792d0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964296Z.964296: gabble_vcard_manager_finalize (vcard-manager.c:607): 0xb792d0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964374Z.964374: gabble_jingle_factory_dispose (jingle-factory.c:485): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964463Z.964463: user_data_destroyed_cb (util.c:935): user_data for 0xb9b280 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964586Z.964586: gabble_presence_cache_dispose (presence-cache.c:538): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.964929Z.964929: gabble_presence_cache_finalize (presence-cache.c:569): called with 0xb4caa0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965272Z.965272: gabble_roster_dispose (roster.c:201): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965364Z.965364: gabble_roster_close_all (roster.c:1672): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965459Z.965459: gabble_roster_finalize (roster.c:233): called with 0xb5a200 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965548Z.965548: gabble_im_factory_dispose (im-factory.c:125): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965641Z.965641: gabble_roomlist_manager_dispose (roomlist-manager.c:129): running (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965716Z.965716: gabble_roomlist_manager_close_all (roomlist-manager.c:87): 0xb45cc0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965806Z.965806: gabble_search_manager_dispose (search-manager.c:212): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965880Z.965880: gabble_search_manager_close_all (search-manager.c:98): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.965967Z.965967: user_data_destroyed_cb (util.c:935): user_data for 0xb96540 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966061Z.966061: gabble_auth_manager_dispose (auth-manager.c:158): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966132Z.966132: gabble_auth_manager_close_all (auth-manager.c:89): called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966224Z.966224: user_data_destroyed_cb (util.c:935): user_data for 0xb9b0c0 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966316Z.966316: gabble_server_tls_manager_dispose (server-tls-manager.c:309): 0xb54400 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966410Z.966410: user_data_destroyed_cb (util.c:935): user_data for 0xb9b220 destroyed; disconnecting (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966500Z.966500: gabble_server_tls_manager_finalize (server-tls-manager.c:326): 0xb54400 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966584Z.966584: gabble_muc_factory_dispose (muc-factory.c:158): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966657Z.966657: gabble_muc_factory_close_all (muc-factory.c:885): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966752Z.966752: gabble_private_tubes_factory_dispose (private-tubes-factory.c:179): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966829Z.966829: gabble_private_tubes_factory_close_all (private-tubes-factory.c:358): closing 1-1 tubes channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966921Z.966921: gabble_media_factory_dispose (media-factory.c:164): dispose called (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.966994Z.966994: gabble_media_factory_close_all (media-factory.c:428): closing channels (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.967259Z.967259: gabble_connection_finalize (connection.c:1198): called with 0xb7e3e0 (telepathy-gabble:23436): tp-glib/connection-DEBUG: 2011-01-26T13:51:08.967338Z.967338: tp_contacts_mixin_finalize: 0xb7e3e0 (telepathy-gabble:23436): tp-glib/presence-DEBUG: 2011-01-26T13:51:08.967440Z.967440: tp_presence_mixin_finalize: 0xb7e3e0 (telepathy-gabble:23436): gabble-DEBUG: 2011-01-26T13:51:08.967517Z.967517: gabble_capabilities_finalize (capabilities.c:314): 0xb7e3e0 ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.967826Z.967826: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.967943Z.967943: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.968049Z.968049: send_iq_async failed: Stream closed ** (telepathy-gabble:23436): DEBUG: 2011-01-26T13:51:08.968153Z.968153: send_iq_async failed: Stream closed (telepathy-gabble:23436): wocky-DEBUG: 2011-01-26T13:51:08.968373Z.968373: wocky_porter_finalize: wocky-porter.c:638: finalize porter 0xbd1400 tp-glib-Message: 2011-01-26T13:51:09.051271Z.051271: Got disconnected from the session bus tp-glib-Message: 2011-01-26T13:51:09.051818Z.051818: Exiting (telepathy-gabble:23436): tp-glib/proxy-DEBUG: 2011-01-26T13:51:09.051951Z.051951: tp_proxy_dispose: 0xb4c8f0 (telepathy-gabble:23436): tp-glib/proxy-DEBUG: 2011-01-26T13:51:09.052022Z.052022: tp_proxy_invalidate: 0xb4c8f0: Proxy unreferenced (telepathy-gabble:23436): tp-glib/proxy-DEBUG: 2011-01-26T13:51:09.052122Z.052122: tp_proxy_finalize: 0xb4c8f0 profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/debug.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/interfaces.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/gtypes.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/heap.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/intset.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/channel-iface.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/util.gcda:Merge mismatch for summaries profiling:/home/cassidy/dev/telepathy-glib/telepathy-glib/.libs/signals-marshal.gcda:Merge mismatch for summaries