2011-07-28T07:05:15.090415 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='35308822720' type='set' to='user2@domain.com/c5c574e6' from='user1@domain.com/6ceeff0e' * si xmlns='http://jabber.org/protocol/si' profile='http://jabber.org/protocol/si/profile/file-transfer' id='1311807913-3229273191' * feature xmlns='http://jabber.org/protocol/feature-neg' * x xmlns='jabber:x:data' type='form' * field type='list-single' var='stream-method' * option * value "http://jabber.org/protocol/bytestreams" * option * value "http://jabber.org/protocol/ibb" * si-multiple xmlns='http://telepathy.freedesktop.org/xmpp/si-multiple' * file xmlns='http://jabber.org/protocol/si/profile/file-transfer' hash='d6c9c7d01b892a9f0f4d1201ecb3a7c5' name='f-004.pdf' date='2011-06-22T11:56:37Z' mime-type='application/pdf' size='214226' * desc * range 2011-07-28T07:05:15.090923 gabble/bytestream:5 streaminit_parse_request (bytestream-factory.c:926): Got stream-method http://jabber.org/protocol/bytestreams 2011-07-28T07:05:15.091324 gabble/bytestream:5 streaminit_parse_request (bytestream-factory.c:926): Got stream-method http://jabber.org/protocol/ibb 2011-07-28T07:05:15.091628 gabble/bytestream:5 bytestream_factory_iq_si_cb (bytestream-factory.c:1144): received a SI request 2011-07-28T07:05:15.092071 gabble/bytestream:5 bytestream_factory_iq_si_cb (bytestream-factory.c:1200): Receiver supports multi bytestreams 2011-07-28T07:05:15.092535 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce08:state-changed with context 0x8c82cc0 2011-07-28T07:05:15.092886 gabble/bytestream:5 gabble_bytestream_factory_create_multiple (bytestream-factory.c:1889): add multi bytestream <1311807913-3229273191> from 2011-07-28T07:05:15.093265 gabble/bytestream:5 bytestream_factory_iq_si_cb (bytestream-factory.c:1216): add http://jabber.org/protocol/bytestreams to multi-bytestream methods 2011-07-28T07:05:15.093569 gabble/bytestream:5 gabble_bytestream_multiple_add_stream_method (bytestream-multiple.c:622): Add bytestream method http://jabber.org/protocol/bytestreams 2011-07-28T07:05:15.099103 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b72190:state-changed with context 0x8c82c50 2011-07-28T07:05:15.101347 gabble/bytestream:5 gabble_bytestream_factory_create_socks5 (bytestream-factory.c:1852): add SOCKS5 bytestream <1311807913-3229273191> from 2011-07-28T07:05:15.104177 gabble/bytestream:5 bytestream_factory_iq_si_cb (bytestream-factory.c:1216): add http://jabber.org/protocol/ibb to multi-bytestream methods 2011-07-28T07:05:15.106367 gabble/bytestream:5 gabble_bytestream_multiple_add_stream_method (bytestream-multiple.c:622): Add bytestream method http://jabber.org/protocol/ibb 2011-07-28T07:05:15.108763 gabble/file-transfer:5 set_bytestream (ft-channel.c:1225): Setting bytestream to 0x8b6ce08 2011-07-28T07:05:15.109216 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce08:state-changed with context 0x8c7e010 2011-07-28T07:05:15.109551 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce08:write-blocked with context 0x8c7dfb0 2011-07-28T07:05:15.110168 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b71850:presences-updated with context 0x8c77f80 2011-07-28T07:05:15.110526 gabble/file-transfer:5 gabble_file_transfer_channel_constructor (ft-channel.c:550): New FT channel created: /org/freedesktop/Telepathy/Connection/gabble/jabber/user2_40test_2edomain_2ecom_2fc5c574e6/FileTransferChannel/0x8b75150 (contact: user1@domain.com, initiator: user1@domain.com, file: "f-004.pdf", size: 214226) 2011-07-28T07:05:15.110898 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b75150:closed with context 0x8c77f30 2011-07-28T07:05:32.230338 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='33129230201' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:05:32.441812 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='33129230201' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:06:02.255590 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='33290255452' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:06:02.829082 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='33290255452' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:06:32.263225 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='379262989' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:06:32.474091 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='379262989' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:07:02.272914 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='2102272778' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:07:02.574512 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='2102272778' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:07:26.841248 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8c1d100:new-connection with context 0x8c7e170 2011-07-28T07:07:26.841720 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce08:data-received with context 0x8c4b170 2011-07-28T07:07:26.842149 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' to='user1@domain.com/6ceeff0e' type='result' id='35308822720' * si xmlns='http://jabber.org/protocol/si' * si-multiple xmlns='http://telepathy.freedesktop.org/xmpp/si-multiple' * value "http://jabber.org/protocol/bytestreams" * value "http://jabber.org/protocol/ibb" * file xmlns='http://jabber.org/protocol/si/profile/file-transfer' 2011-07-28T07:07:26.844702 gabble/bytestream:5 gabble_bytestream_multiple_accept (bytestream-multiple.c:429): stream 1311807913-3229273191 with user1@domain.com/6ceeff0e is now accepted 2011-07-28T07:07:27.275336 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='2719273278' type='set' to='user2@domain.com/c5c574e6' from='user1@domain.com/6ceeff0e' * query xmlns='http://jabber.org/protocol/bytestreams' mode='tcp' sid='1311807913-3229273191' * streamhost jid='user1@domain.com/6ceeff0e' port='43285' host='192.168.2.56' * streamhost jid='proxy.eu.jabber.org' port='7777' host='91.121.109.155' * streamhost jid='proxy65.spacelabs.nl' port='5000' host='192.87.65.59' 2011-07-28T07:07:27.275926 gabble/bytestream:5 gabble_bytestream_socks5_add_streamhost (bytestream-socks5.c:1317): streamhost with jid user1@domain.com/6ceeff0e, host 192.168.2.56 and port 43285 added 2011-07-28T07:07:27.276329 gabble/bytestream:5 gabble_bytestream_socks5_add_streamhost (bytestream-socks5.c:1317): streamhost with jid proxy.eu.jabber.org, host 91.121.109.155 and port 7777 added 2011-07-28T07:07:27.276653 gabble/bytestream:5 gabble_bytestream_socks5_add_streamhost (bytestream-socks5.c:1317): streamhost with jid proxy65.spacelabs.nl, host 192.87.65.59 and port 5000 added 2011-07-28T07:07:27.276964 gabble/bytestream:5 socks5_connect (bytestream-socks5.c:1238): Trying streamhost 192.168.2.56 on port 43285 2011-07-28T07:07:32.278863 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='105278719' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:07:32.486588 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='105278719' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:07:37.100656 gabble/bytestream:5 socks5_timer_cb (bytestream-socks5.c:714): Timed out; closing SOCKS5 connection 2011-07-28T07:07:37.101296 gabble/bytestream:5 socks5_error (bytestream-socks5.c:649): connection to streamhost failed, trying the next one 2011-07-28T07:07:37.101727 gabble/bytestream:5 socks5_connect (bytestream-socks5.c:1238): Trying streamhost 91.121.109.155 on port 7777 2011-07-28T07:07:37.291344 gabble/bytestream:5 transport_connected_cb (bytestream-socks5.c:511): transport is connected. Sending auth request 2011-07-28T07:08:02.284338 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='4680284187' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:08:02.491818 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='4680284187' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:08:32.314762 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='34887314652' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:08:32.518449 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='34887314652' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:09:02.334462 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='6330334322' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:09:02.537347 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='6330334322' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:09:32.345236 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='701344964' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:09:32.556428 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='701344964' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:10:02.362761 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='35002362641' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:10:02.571297 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='35002362641' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:10:32.739557 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='2235739476' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:10:33.233762 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='2235739476' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:11:02.755249 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='33088755069' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:11:02.960813 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='33088755069' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:11:32.771574 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='33117771434' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:11:32.976438 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='33117771434' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:12:01.725085 gabble/bytestream:5 transport_disconnected_cb (bytestream-socks5.c:533): Sock5 transport disconnected 2011-07-28T07:12:01.725503 gabble/bytestream:5 socks5_error (bytestream-socks5.c:649): connection to streamhost failed, trying the next one 2011-07-28T07:12:01.725814 gabble/bytestream:5 socks5_connect (bytestream-socks5.c:1238): Trying streamhost 192.87.65.59 on port 5000 2011-07-28T07:12:01.931435 gabble/bytestream:5 transport_connected_cb (bytestream-socks5.c:511): transport is connected. Sending auth request 2011-07-28T07:12:02.140151 gabble/bytestream:5 socks5_handle_received_data (bytestream-socks5.c:886): Received auth reply. Sending CONNECT command 2011-07-28T07:12:02.345699 gabble/bytestream:5 target_got_connect_reply (bytestream-socks5.c:740): Received CONNECT reply. Socks5 stream connected. Bytestream is now open 2011-07-28T07:12:02.346297 gabble/file-transfer:5 channel_open (ft-channel.c:1141): Channel open 2011-07-28T07:12:02.347155 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='result' to='user1@domain.com/6ceeff0e' id='2719273278' * query xmlns='http://jabber.org/protocol/bytestreams' * streamhost-used jid='proxy65.spacelabs.nl' 2011-07-28T07:12:02.347852 gabble/bytestream:5 target_got_connect_reply (bytestream-socks5.c:772): reading has been blocked. Blocking now as the socks5 negotiation is done 2011-07-28T07:12:02.359416 gabble/file-transfer:5 new_connection_cb (ft-channel.c:2106): Client connected to local socket 2011-07-28T07:12:02.359807 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce50:disconnected with context 0x8c77e20 2011-07-28T07:12:02.360220 gabble/jid:5 gabble_signal_connect_weak (util.c:966): connecting to 0x8b6ce50:buffer-empty with context 0x8c77e50 2011-07-28T07:12:02.360584 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c7e170 destroyed; cleaning up 2011-07-28T07:12:03.043045 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='3359842912' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:12:03.526487 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='3359842912' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:12:12.651777 gabble/bytestream:5 transport_disconnected_cb (bytestream-socks5.c:533): Sock5 transport disconnected 2011-07-28T07:12:12.652360 gabble/bytestream:5 socks5_error (bytestream-socks5.c:675): error, closing the connection 2011-07-28T07:12:12.652806 gabble/bytestream:5 gabble_bytestream_socks5_close (bytestream-socks5.c:1509): Transport buffer is empty, we can close the bytestream 2011-07-28T07:12:12.653259 gabble/bytestream:5 remove_bytestream (bytestream-factory.c:817): removing bytestream: <1311807913-3229273191> from 2011-07-28T07:12:12.653625 gabble/bytestream:5 remove_bytestream (bytestream-factory.c:817): removing bytestream: <1311807913-3229273191> from 2011-07-28T07:12:12.654211 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c82c50 destroyed; cleaning up 2011-07-28T07:12:12.677649 gabble/file-transfer:5 transport_disconnected_cb (ft-channel.c:2052): transport to local socket has been disconnected 2011-07-28T07:12:12.678107 gabble/file-transfer:5 close_session_and_transport (ft-channel.c:981): Closing session and transport 2011-07-28T07:12:12.678440 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c82cc0 destroyed; cleaning up 2011-07-28T07:12:12.678744 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c7e010 destroyed; cleaning up 2011-07-28T07:12:12.679099 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c7dfb0 destroyed; cleaning up 2011-07-28T07:12:12.679399 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c4b170 destroyed; cleaning up 2011-07-28T07:12:12.679725 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c77e20 destroyed; cleaning up 2011-07-28T07:12:12.682334 gabble/jid:5 instance_destroyed_cb (util.c:922): instance for 0x8c77e50 destroyed; cleaning up 2011-07-28T07:12:33.056858 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='3923256719' * ping xmlns='urn:xmpp:ping' 2011-07-28T07:12:33.260829 wocky:5 _end_element_ns: Received stanza * iq xmlns='jabber:client' id='3923256719' type='result' to='user2@domain.com/c5c574e6' 2011-07-28T07:13:03.065924 wocky:5 _write_node_tree: Serializing tree: * iq xmlns='jabber:client' type='get' id='18665786'