[16:36:29 JABBER] PS_SETSTATUS( 40072 )
[16:36:29 JABBER] Thread started: type=0
[16:36:29 JABBER] SetAwayMsg called, wParam=40072 lParam=Yep, I'm here!
[16:36:29 JABBER] _xmpp-client._tcp.jabber.ru not resolved
[16:36:29 JABBER] Thread type=0 server='jabber.ru' port='5223'
[16:36:30 JABBER] (1244) Connected to jabber.ru:5223
[16:36:30 JABBER] Local IP = 10.0.0.40
[16:36:30 JABBER] Intializing SSL connection
[16:36:30 JABBER] SSL using socket = 1244
[16:36:30 JABBER] SSL create context ok
[16:36:30 JABBER] SSL set fd ok
[16:36:30 JABBER] SSL negotiation ok
[16:36:30 JABBER] SSL enabled for handle = 50078248
[16:36:30 JABBER] Stream is initializing after connect
[16:36:30 JABBER] ( SSL ) Data sent
<?xml version='1.0' encoding='UTF-8'?><stream:stream to='jabber.ru' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' xml:lang='en' version='1.0'>
[16:36:30 JABBER] Entering main recv loop
[16:36:30 JABBER] recvResult = 167
[16:36:30 JABBER] ( SSL ) Data received
<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='2639933884' from='jabber.ru' version='1.0' xml:lang='en'>
[16:36:30 JABBER] XML: skip <?xml> tag
[16:36:30 JABBER] bytesParsed = 167
[16:36:30 JABBER] recvResult = 220
[16:36:30 JABBER] ( SSL ) Data received
<stream:features><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism><mechanism>PLAIN</mechanism></mechanisms><register xmlns='http://jabber.org/features/iq-register'/></stream:features>
[16:36:30 JABBER] ( SSL ) Data sent
<auth xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
[16:36:30 JABBER] bytesParsed = 220
[16:36:30 JABBER] recvResult = 148
[16:36:30 JABBER] ( SSL ) Data received
<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IjIyODE5NDk3NjYiLHFvcD0iYXV0aCIsY2hhcnNldD11dGYtOCxhbGdvcml0aG09bWQ1LXNlc3M=</challenge>
[16:36:30 JABBER] MD5 challenge = <nonce="2281949766",qop="auth",charset=utf-8,algorithm=md5-sess>
[16:36:30 JABBER] ( SSL ) Data sent
<response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>dXNlcm5hbWU9InJhbXRhbXRhbSIscmVhbG09IiIsbm9uY2U9IjIyODE5NDk3NjYiLGNub25jZT0iNTFlZmVjNjk5NjcwYzgyZjMwNmMxYjgyNTFiOGE2YWUiLG5jPTAwMDAwMDAxLHFvcD1hdXRoLGRpZ2VzdC11cmk9InhtcHAvamFiYmVyLnJ1IixjaGFyc2V0PXV0Zi04LHJlc3BvbnNlPTA4NjVmOGZlYTgzY2I0ZTUxYzhlN2Q3Y2MwMTlmMWVl</response>
[16:36:30 JABBER] bytesParsed = 148
[16:36:30 JABBER] recvResult = 120
[16:36:30 JABBER] ( SSL ) Data received
<challenge xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>cnNwYXV0aD03Njg0MDNkMzRiMmVjMDk3NDRjNGJjODE3NTMzOWM0Yg==</challenge>
[16:36:30 JABBER] ( SSL ) Data sent
<response xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
[16:36:30 JABBER] bytesParsed = 120
[16:36:30 JABBER] recvResult = 51
[16:36:30 JABBER] ( SSL ) Data received
<success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
[16:36:30 JABBER] Success: Logged-in.
[16:36:30 JABBER] Stream will be initialized after successful sasl
[16:36:30 JABBER] bytesParsed = 51
[16:36:30 JABBER] Stream is initializing after successful sasl
[16:36:30 JABBER] ( SSL ) Data sent
<?xml version='1.0' encoding='UTF-8'?><stream:stream to='jabber.ru' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' xml:lang='en' version='1.0'>
[16:36:30 JABBER] recvResult = 167
[16:36:30 JABBER] ( SSL ) Data received
<?xml version='1.0'?><stream:stream xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' id='3295462615' from='jabber.ru' version='1.0' xml:lang='en'>
[16:36:30 JABBER] XML: skip <?xml> tag
[16:36:30 JABBER] bytesParsed = 167
[16:36:31 JABBER] recvResult = 137
[16:36:31 JABBER] ( SSL ) Data received
<stream:features><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'/><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></stream:features>
[16:36:31 JABBER] IqAdd id=10, proc=0, func=0x127b27a6
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='set' id='mir_10'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><resource>Miranda</resource></bind></iq>
[16:36:31 JABBER] bytesParsed = 137
[16:36:31 JABBER] recvResult = 127
[16:36:31 JABBER] ( SSL ) Data received
<iq id='mir_10' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>ramtamtam@jabber.ru/Miranda</jid></bind></iq>
[16:36:31 JABBER] Handling iq request for id=10
[16:36:31 JABBER] Result Bind: ramtamtam@jabber.ru/Miranda confirmed. (null)
[16:36:31 JABBER] IqAdd id=11, proc=0, func=0x127b2a87
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='set' id='mir_11'><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></iq>
[16:36:31 JABBER] bytesParsed = 127
[16:36:31 JABBER] recvResult = 89
[16:36:31 JABBER] ( SSL ) Data received
<iq type='result' id='mir_11'><session xmlns='urn:ietf:params:xml:ns:xmpp-session'/></iq>
[16:36:31 JABBER] Handling iq request for id=11
[16:36:31 JABBER] IqAdd id=12, proc=0, func=0x127b2c52
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' id='mir_12'><query xmlns='jabber:iq:roster'/></iq>
[16:36:31 JABBER] IqAdd id=13, proc=11, func=0x127b5a57
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' id='mir_13'><query xmlns='jabber:iq:private'><storage xmlns='storage:bookmarks'/></query></iq>
[16:36:31 JABBER] IqAdd id=14, proc=0, func=0x127b1fb2
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' to='jabber.ru' id='mir_14'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' id='mir_15'><query xmlns='jabber:iq:privacy'/></iq>
[16:36:31 JABBER] bytesParsed = 89
[16:36:31 JABBER] recvResult = 302
[16:36:31 JABBER] ( SSL ) Data received
<iq from='ramtamtam@jabber.ru/Miranda' to='ramtamtam@jabber.ru/Miranda' id='mir_12' type='result'><query xmlns='jabber:iq:roster'><item subscription='to' jid='private@disk.jabbim.cz'/><item subscription='to' jid='public@disk.jabbim.cz'/><item subscription='both' jid='risk@jabber.ccc.de'/></query></iq>
[16:36:31 JABBER] Handling iq request for id=12
[16:36:31 JABBER] <iq/> iqIdGetRoster
[16:36:31 JABBER] Status changed via THREADSTART
[16:36:31 JABBER] ( SSL ) Data sent
<presence><priority>0</priority><c xmlns='http://jabber.org/protocol/caps' node='http://miranda-im.org/caps' ver='0.7.0.10' ext='secureim'/><x xmlns='jabber:x:avatar'><hash>bc4c79a0ee54d667a3c1c9a5730b48ff4cd55566</hash></x><x xmlns='vcard-temp:x:update'><photo>bc4c79a0ee54d667a3c1c9a5730b48ff4cd55566</photo></x><status>Yep, I&apos;m here!</status></presence>
[16:36:31 JABBER] bytesParsed = 302
[16:36:31 JABBER] recvResult = 129
[16:36:31 JABBER] ( SSL ) Data received
<iq from='ramtamtam@jabber.ru' to='ramtamtam@jabber.ru/Miranda' id='mir_15' type='result'><query xmlns='jabber:iq:privacy'/></iq>
[16:36:31 JABBER] bytesParsed = 129
[16:36:31 JABBER] recvResult = 721
[16:36:31 JABBER] ( SSL ) Data received
<iq from='jabber.ru' to='ramtamtam@jabber.ru/Miranda' id='mir_14' type='result'><query xmlns='http://jabber.org/protocol/disco#info'><identity category='server' type='im' name='ejabberd'/><feature var='http://ejabberd.jabberstudio.org/protocol/configure'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='http://jabber.org/protocol/disco#publish'/><feature var='http://jabber.org/protocol/stats'/><feature var='iq'/><feature var='jabber:iq:last'/><feature var='jabber:iq:register'/><feature var='jabber:iq:time'/><feature var='jabber:iq:version'/><feature var='presence'/><feature var='presence-invisible'/><feature var='vcard-temp'/></query></iq>
[16:36:31 JABBER] Handling iq request for id=14
[16:36:31 JABBER] bytesParsed = 721
[16:36:31 JABBER] recvResult = 305
[16:36:31 JABBER] ( SSL ) Data received
<iq from='ramtamtam@jabber.ru' to='ramtamtam@jabber.ru/Miranda' id='mir_13' type='result'><query xmlns='jabber:iq:private'><storage xmlns='storage:bookmarks'><conference jid='miranda-de%irc.freenode.net@irc.jabber.no' name='Miranda-de'><nick>RamTAMtam</nick><password/></conference></storage></query></iq>
[16:36:31 JABBER] Handling iq request for id=13
[16:36:31 JABBER] <iq/> iqIdGetBookmarks
[16:36:31 JABBER] bytesParsed = 305
[16:36:31 JABBER] recvResult = 80
[16:36:31 JABBER] ( SSL ) Data received
<presence from='private@disk.jabbim.cz/jdisk' to='ramtamtam@jabber.ru/Miranda'/>
[16:36:31 JABBER] presence: for jid private@disk.jabbim.cz/jdisk
[16:36:31 JABBER] AddQuery 16, private@disk.jabbim.cz/jdisk
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' to='private@disk.jabbim.cz/jdisk' id='mir_16'><query xmlns='jabber:iq:version'/></iq>
[16:36:31 JABBER] ResolverThread started
[16:36:31 JABBER] JabberUpdateJidDbSettings: updating jid private@disk.jabbim.cz to rc jdisk
[16:36:31 JABBER] JabberUpdateMirVer: for rc jdisk: jdisk
[16:36:31 (NULL)] flags.dll: ME_CLIST_EXTRA_APPLY_IMAGE event occured (hContact=0x459EDE,szName=private@disk.jabbim.cz)
[16:36:31 (NULL)] flags.dll: MS_CLIST_EXTRA_SET_ICON(hContact=0x459EDE,szName=private@disk.jabbim.cz,columnId=-1,hImage=1)
[16:36:31 JABBER] private ( private@disk.jabbim.cz/jdisk ) online, set contact status to Online
[16:36:31 JABBER] Avatar enabled
[16:36:31 JABBER] Not hasXAvatar
[16:36:31 JABBER] bytesParsed = 80
[16:36:31 JABBER] recvResult = 79
[16:36:31 JABBER] ( SSL ) Data received
<presence from='public@disk.jabbim.cz/jdisk' to='ramtamtam@jabber.ru/Miranda'/>
[16:36:31 JABBER] presence: for jid public@disk.jabbim.cz/jdisk
[16:36:31 JABBER] AddQuery 17, public@disk.jabbim.cz/jdisk
[16:36:31 JABBER] ( SSL ) Data sent
<iq type='get' to='public@disk.jabbim.cz/jdisk' id='mir_17'><query xmlns='jabber:iq:version'/></iq>
[16:36:31 JABBER] JabberUpdateJidDbSettings: updating jid public@disk.jabbim.cz to rc jdisk
[16:36:31 JABBER] JabberUpdateMirVer: for rc jdisk: jdisk
[16:36:31 (NULL)] flags.dll: ME_CLIST_EXTRA_APPLY_IMAGE event occured (hContact=0x459C38,szName=public@disk.jabbim.cz)
[16:36:31 (NULL)] flags.dll: MS_CLIST_EXTRA_SET_ICON(hContact=0x459C38,szName=public@disk.jabbim.cz,columnId=-1,hImage=1)
[16:36:31 JABBER] public ( public@disk.jabbim.cz/jdisk ) online, set contact status to Online
[16:36:31 JABBER] Avatar enabled
[16:36:31 JABBER] Not hasXAvatar
[16:36:31 JABBER] bytesParsed = 79
[16:36:31 JABBER] recvResult = 521
[16:36:31 JABBER] ( SSL ) Data received
<presence from='risk@jabber.ccc.de/Miranda IM' to='ramtamtam@jabber.ru/Miranda'><priority>2</priority><c xmlns='http://jabber.org/protocol/caps' ext='secureim' ver='0.7.0.10' node='http://miranda-im.org/caps'/><x xmlns='jabber:x:avatar'><hash>ebc73e531a2df93fb71f88640497588d5f04e317</hash></x><x xmlns='vcard-temp:x:update'><photo>ebc73e531a2df93fb71f88640497588d5f04e317</photo></x><status>No R(i)SK - no fun!</status><x xmlns='jabber:x:delay' from='risk@jabber.ccc.de/Miranda IM' stamp='20070710T14:07:50'/></presence>
[16:36:31 JABBER] presence: for jid risk@jabber.ccc.de/Miranda IM
[16:36:31 JABBER] JabberUpdateMirVer: for rc Miranda IM: http://miranda-im.org/caps#0.7.0.10
[16:36:31 JABBER] CAPS: get caps 7467fcfd for: http://miranda-im.org/caps, 0.7.0.10
[16:36:31 JABBER] CAPS: get caps 10000000 for: http://miranda-im.org/caps, secureim
[16:36:31 JABBER] JabberUpdateJidDbSettings: updating jid risk@jabber.ccc.de to rc Miranda IM
[16:36:31 JABBER] JabberUpdateMirVer: for rc Miranda IM: http://miranda-im.org/caps#0.7.0.10
[16:36:31 (NULL)] flags.dll: ME_CLIST_EXTRA_APPLY_IMAGE event occured (hContact=0x2F32D,szName=R(i)SK)
[16:36:31 (NULL)] flags.dll: MS_CLIST_EXTRA_SET_ICON(hContact=0x2F32D,szName=R(i)SK,columnId=68,hImage=1)
[16:36:31 JABBER] risk ( risk@jabber.ccc.de/Miranda IM ) online, set contact status to Online
[16:36:31 JABBER] Avatar enabled
[16:36:31 JABBER] AvatarXVcard deleted
[16:36:31 JABBER] Avatar was changed
[16:36:31 JABBER] bytesParsed = 521
[16:36:35 JABBER] Avatar is Ok: ebc73e531a2df93fb71f88640497588d5f04e317 == ebc73e531a2df93fb71f88640497588d5f04e317
[16:36:41 JABBER] Expire query 17, public@disk.jabbim.cz/jdisk
[16:36:41 JABBER] IqAdd id=18, proc=0, func=0x127a7575
[16:36:41 JABBER] ( SSL ) Data sent
<iq type='get' to='public@disk.jabbim.cz/jdisk' id='mir_18'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
[16:36:41 JABBER] Expire query 16, private@disk.jabbim.cz/jdisk
[16:36:41 JABBER] IqAdd id=19, proc=0, func=0x127a7575
[16:36:41 JABBER] ( SSL ) Data sent
<iq type='get' to='private@disk.jabbim.cz/jdisk' id='mir_19'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
[16:36:41 JABBER] ResolverThread stopped
[16:36:41 JABBER] recvResult = 599
[16:36:41 JABBER] ( SSL ) Data received
<iq from='public@disk.jabbim.cz/jdisk' to='ramtamtam@jabber.ru/Miranda' type='result' id='mir_18' xml:lang='en'><query xmlns='http://jabber.org/protocol/disco#info'><feature var='jabber:iq:register'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='http://jabber.org/protocol/stats'/><identity name='Public disk' category='store' type='file'/><feature var='http://jabber.org/protocol/bytestreams'/><feature var='http://jabber.org/protocol/si'/><feature var='http://jabber.org/protocol/si/profile/file-transfer'/></query></iq>
[16:36:41 JABBER] Handling iq request for id=18
[16:36:41 JABBER] bytesParsed = 599
[16:36:42 JABBER] recvResult = 601
[16:36:42 JABBER] ( SSL ) Data received
<iq from='private@disk.jabbim.cz/jdisk' to='ramtamtam@jabber.ru/Miranda' type='result' id='mir_19' xml:lang='en'><query xmlns='http://jabber.org/protocol/disco#info'><feature var='jabber:iq:register'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='http://jabber.org/protocol/stats'/><identity name='Private disk' category='store' type='file'/><feature var='http://jabber.org/protocol/bytestreams'/><feature var='http://jabber.org/protocol/si'/><feature var='http://jabber.org/protocol/si/profile/file-transfer'/></query></iq>
[16:36:42 JABBER] Handling iq request for id=19
[16:36:42 JABBER] bytesParsed = 601
[16:36:53 JABBER] CAPS: get caps 7467fcfd for: http://miranda-im.org/caps, 0.7.0.10
[16:36:53 JABBER] CAPS: get caps 10000000 for: http://miranda-im.org/caps, secureim
[16:36:53 JABBER] ( SSL ) Data sent
<iq type='set' to='risk@jabber.ccc.de/Miranda IM' id='mir_20'><si xmlns='http://jabber.org/protocol/si' id='80023690' mime-type='binary/octet-stream' profile='http://jabber.org/protocol/si/profile/file-transfer'><file name='langpack_german.tx' size='520897' xmlns='http://jabber.org/protocol/si/profile/file-transfer'><desc></desc></file><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='form'><field var='stream-method' type='list-single'><option><value>http://jabber.org/protocol/bytestreams</value></option><option><value>http://jabber.org/protocol/ibb</value></option></field></x></feature></si></iq>
[16:36:57 JABBER] recvResult = 349
[16:36:57 JABBER] ( SSL ) Data received
<iq from='risk@jabber.ccc.de/Miranda IM' to='ramtamtam@jabber.ru/Miranda' id='mir_20' type='result'><si xmlns='http://jabber.org/protocol/si'><feature xmlns='http://jabber.org/protocol/feature-neg'><x xmlns='jabber:x:data' type='submit'><field var='stream-method'><value>http://jabber.org/protocol/bytestreams</value></field></x></feature></si></iq>
[16:36:57 JABBER] bytesParsed = 349
[16:36:57 JABBER] Thread started: type=bytestream_send
[16:36:57 (NULL)] UPnP port mapping failed. Internal Port: 24505

[16:36:57 JABBER] (1124) Port 24505 opened for incoming connections
[16:36:57 JABBER] ( SSL ) Data sent
<iq type='set' to='risk@jabber.ccc.de/Miranda IM' id='mir_21'><query xmlns='http://jabber.org/protocol/bytestreams' sid='80023690'><streamhost jid='ramtamtam@jabber.ru/Miranda' host='risk.dnsalias.net' port='24505'/></query></iq>
[16:36:57 JABBER] New incoming connection on port 24505 from 10.0.0.40 (1408)
[16:36:57 JABBER] bytestream_send_connection incoming connection accepted: local_port=24505
[16:36:57 JABBER] (03003498:4294967295) Connection closed
[16:36:57 JABBER] bytestream_send_connection closing connection
[16:37:00 JABBER] New incoming connection on port 24505 from 10.0.0.40 (2000)
[16:37:00 JABBER] bytestream_send_connection incoming connection accepted: local_port=24505
[16:37:00 JABBER] (03003498:4294967295) Connection closed
[16:37:00 JABBER] bytestream_send_connection closing connection
[16:37:06 JABBER] New incoming connection on port 24505 from 10.0.0.40 (1408)
[16:37:06 JABBER] bytestream_send_connection incoming connection accepted: local_port=24505
[16:37:06 JABBER] (03003498:4294967295) Connection closed
[16:37:06 JABBER] bytestream_send_connection closing connection
[16:37:18 JABBER] recvResult = 205
[16:37:18 JABBER] ( SSL ) Data received
<iq from='risk@jabber.ccc.de/Miranda IM' to='ramtamtam@jabber.ru/Miranda' id='mir_21' type='error'><error type='cancel' code='404'><item-not-found xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq>
[16:37:18 JABBER] bytesParsed = 205
[16:37:18 JABBER] File transfer complete with error
[16:37:18 JABBER] Destroying file transfer session 0301F2E8
[16:37:30 JABBER] ( SSL ) Data sent
 	 
[16:37:37 JABBER] PS_SETSTATUS( 40071 )
[16:37:37 JABBER] ( SSL ) Data sent
</stream:stream>
[16:37:37 JABBER] recvResult = -1
[16:37:37 JABBER] Exiting KeepAliveThread
[16:37:37 JABBER] (02FC2228:4294967295) Connection closed
[16:37:37 JABBER] Thread ended: type=0 server='jabber.ru'
[16:37:37 JABBER] Exiting ServerThread