Sometimes my contacts appear groupless and without nicknames. I have to re-logon to get the contact list right. Debug log with the problem follows. Suspicious messages include “Handling AIM-style auth.” (this is ICQ) and “AIM got buddy item BuddyItem for 256995594 (buddy 0x1798 in group 0x1): alias=Zuzka, comment=“null””, this is correct but again, this is ICQ not AIM (otherwise, the contact details are correct). Then, there is a log message including some binary data which is hard to copy&paste here…(see end of log):
Cheers,
Filip
2006.11.15 08:41:29 icq: rosterLoaded fkonvick
2006.11.15 08:41:29 Received presence packet:
2006.11.15 08:41:30 OSCAR login service state change from CONNECTING to CONNECTED
2006.11.15 08:41:30 Handling AIM-style auth.
2006.11.15 08:41:30 Got auth response!
2006.11.15 08:41:30 Got something else?
2006.11.15 08:41:30 OSCAR bos service state change from NOT_CONNECTED to INITING
2006.11.15 08:41:30 OSCAR bos service state change from INITING to RESOLVING
2006.11.15 08:41:30 OSCAR bos service state change from RESOLVING to CONNECTING
2006.11.15 08:41:30 OSCAR login service state change from CONNECTED to NOT_CONNECTED
2006.11.15 08:41:30 OSCAR bos service state change from CONNECTING to CONNECTED
2006.11.15 08:41:30 OSCAR bps flap packet received: FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=0, flapCommand=LoginFlapCmd: version=1, cookie=null, flapPacket=FlapPacket (channel=1, seq=35792)
2006.11.15 08:41:30 OSCAR flap packet received: FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=0, flapCommand=LoginFlapCmd: version=1, cookie=null, flapPacket=FlapPacket (channel=1, seq=35792)
2006.11.15 08:41:31 OSCAR bos snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=0, requests: 0, paused=false, snacPacket=SnacPacket type 0x1/0x3: 26 bytes (id=2599426237), snacCommand=ServerReadyCmd: snac families: 1, 2, 3, 4, 6, 8, 9, a, b, c, 13, 15, 22 - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=1, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x3: 26 bytes (id=2599426237), flapPacket=FlapPacket (channel=2, seq=35793)
2006.11.15 08:41:31 OSCAR snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=0, requests: 0, paused=false, snacPacket=SnacPacket type 0x1/0x3: 26 bytes (id=2599426237), snacCommand=ServerReadyCmd: snac families: 1, 2, 3, 4, 6, 8, 9, a, b, c, 13, 15, 22 - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=1, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x3: 26 bytes (id=2599426237), flapPacket=FlapPacket (channel=2, seq=35793)
2006.11.15 08:41:31 OSCAR bos snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=6, requests: 6, paused=false, snacPacket=SnacPacket type 0x1/0x18: 52 bytes (id=2599426507), snacCommand=ServerVersionsCmd: family versions: 1 (v=4), 2 (v=1), 3 (v=1), 4 (v=1), 6 (v=1), 8 (v=1), 9 (v=1), a (v=1), b (v=1), c (v=1), 13 (v=5), 15 (v=2), 22 (v=1), - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=7, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x18: 52 bytes (id=2599426507), flapPacket=FlapPacket (channel=2, seq=35794)
2006.11.15 08:41:31 OSCAR snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=6, requests: 6, paused=false, snacPacket=SnacPacket type 0x1/0x18: 52 bytes (id=2599426507), snacCommand=ServerVersionsCmd: family versions: 1 (v=4), 2 (v=1), 3 (v=1), 4 (v=1), 6 (v=1), 8 (v=1), 9 (v=1), a (v=1), b (v=1), c (v=1), 13 (v=5), 15 (v=2), 22 (v=1), - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=7, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x18: 52 bytes (id=2599426507), flapPacket=FlapPacket (channel=2, seq=35794)
2006.11.15 08:41:31 OSCAR bos snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=6, requests: 6, paused=false, snacPacket=SnacPacket type 0x1/0x13: 14 bytes (id=2599426508), snacCommand=UpdateAdvisory: type=5, message=null - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=7, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x13: 14 bytes (id=2599426508), flapPacket=FlapPacket (channel=2, seq=35795)
2006.11.15 08:41:31 OSCAR snac packet received: SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=6, requests: 6, paused=false, snacPacket=SnacPacket type 0x1/0x13: 14 bytes (id=2599426508), snacCommand=UpdateAdvisory: type=5, message=null - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=7, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x13: 14 bytes (id=2599426508), flapPacket=FlapPacket (channel=2, seq=35795)
2006.11.15 08:41:31 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for RateInfoRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=7, requests: 7, paused=false, snacPacket=SnacPacket type 0x1/0x7: 1017 bytes (id=2), snacCommand=RateInfoCmd: RateClassInfo for class 1, currentAvg=5859, windowSize=80, clearAvg=2500, warnAvg=2000, limitedAvg=1500, disconnectAvg=800, max=6000, timeSinceLastCommand=0, currentState=0, families: 194 - RateClassInfo for class 2, currentAvg=6000, windowSize=80, clearAvg=3000, warnAvg=2000, limitedAvg=1500, disconnectAvg=1000, max=6000, timeSinceLastCommand=707, currentState=0, families: 6 - RateClassInfo for class 3, currentAvg=3500, windowSize=20, clearAvg=3100, warnAvg=2500, limitedAvg=2000, disconnectAvg=1500, max=4500, timeSinceLastCommand=707, currentState=0, families: 3 - RateClassInfo for class 4, currentAvg=6000, windowSize=20, clearAvg=5500, warnAvg=5300, limitedAvg=4200, disconnectAvg=3000, max=8000, timeSinceLastCommand=707, currentState=0, families: 2 - RateClassInfo for class 5, currentAvg=6000, windowSize=10, clearAvg=5500, warnAvg=5300, limitedAvg=4200, disconnectAvg=3000, max=8000, timeSinceLastCommand=707, currentState=0, families: 0 - - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=8, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0x7: 1017 bytes (id=2), flapPacket=FlapPacket (channel=2, seq=35796)
2006.11.15 08:41:31 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for ParamInfoRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=7, requests: 7, paused=false, snacPacket=SnacPacket type 0x4/0x5: 16 bytes (id=3), snacCommand=ParamInfoCmd: paramInfo=<ParamInfo: maxChannel=4, flags=0x3 (FLAG_MISSEDCALLS_ALLOWED | FLAG_CHANMSGS_ALLOWED), maxMsgLen=512, maxSenderWarning=90.0%, maxReceiverWarning=100.9%, minMsgInterval=1000> - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=8, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x4/0x5: 16 bytes (id=3), flapPacket=FlapPacket (channel=2, seq=35797)
2006.11.15 08:41:31 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for LocRightsRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=8, requests: 8, paused=false, snacPacket=SnacPacket type 0x2/0x3: 30 bytes (id=4), snacCommand=LocRightsCmd: max info length=4096 - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=9, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x2/0x3: 30 bytes (id=4), flapPacket=FlapPacket (channel=2, seq=35798)
2006.11.15 08:41:31 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for SsiRightsRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=10, requests: 10, paused=false, snacPacket=SnacPacket type 0x13/0x3: 152 bytes (id=5), snacCommand=SsiRightsCmd: maxima: 0x0: 2600, 0x1: 51, 0x2: 128, 0x3: 128, 0x4: 1, 0x5: 1, 0x6: 50, 0x7: 0, 0x8: 0, 0x9: 3, 0xa: 0, 0xb: 0, 0xc: 0, 0xd: 128, 0xe: 128, 0xf: 20, 0x10: 200, 0x11: 1, 0x12: 0, 0x13: 1, 0x14: 15, 0x15: 1, 0x16: 40, 0x17: 0, 0x18: 0, 0x19: 200, 0x1a: 1, 0x1b: 20, 0x1c: 200, 0x1d: 1, 0x1e: 8, 0x1f: 20, 0x20: 1, 0x21: 0, 0x22: 0, 0x23: 0, - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=11, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x13/0x3: 152 bytes (id=5), flapPacket=FlapPacket (channel=2, seq=35799)
2006.11.15 08:41:32 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for SsiDataRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=10, requests: 10, paused=false, snacPacket=SnacPacket type 0x13/0x6: 1925 bytes (id=6), snacCommand=SsiDataCmd (ssi version=0): 43 items, modified Tue Nov 14 16:49:40 CET 2006 - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=11, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x13/0x6: 1925 bytes (id=6), flapPacket=FlapPacket (channel=2, seq=35800)
2006.11.15 08:41:32 AIM got group item GroupItem for Rodina, groupid=0x1, buddies: 0x7249, 0x724b, 0x41c0, 0x24e0, 0x1798, 0x28ef, 0x6d7a, 0x509b,
2006.11.15 08:41:32 Found group item: GroupItem for Rodina, groupid=0x1, buddies: 0x7249, 0x724b, 0x41c0, 0x24e0, 0x1798, 0x28ef, 0x6d7a, 0x509b, at id 1
2006.11.15 08:41:32 AIM got buddy item BuddyItem for 256995594 (buddy 0x1798 in group 0x1): alias=Zuzka, comment=“null”, alerts:
2006.11.15 08:41:32 Found buddy item: BuddyItem for 256995594 (buddy 0x1798 in group 0x1): alias=Zuzka, comment=“null”, alerts: at id 6040
2006.11.15 08:41:32 AIM got buddy item BuddyItem for 286206671 (buddy 0x24e0 in group 0x1): alias=Eva, comment=“null”, alerts:
2006.11.15 08:41:32 Found buddy item: BuddyItem for 286206671 (buddy 0x24e0 in group 0x1): alias=Eva, comment=“null”, alerts: at id 9440
2006.11.15 08:41:32 AIM got buddy item BuddyItem for 223100190 (buddy 0x28ef in group 0x1): alias=David, comment=“null”, alerts:
2006.11.15 08:41:32 Found buddy item: BuddyItem for 223100190 (buddy 0x28ef in group 0x1): alias=David, comment=“null”, alerts: at id 10479
(…a lot more of these…)
2006.11.15 08:41:32 AIM got group item GroupItem for Transport Buddies, groupid=0x430d, buddies: none
2006.11.15 08:41:32 Found group item: GroupItem for Transport Buddies, groupid=0x430d, buddies: none at id 17165
2006.11.15 08:41:32 icq: Sending packet:
2006.11.15 08:41:32 icq: Sending packet:
2006.11.15 08:41:32 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for MyInfoRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=13, requests: 13, paused=false, snacPacket=SnacPacket type 0x1/0xf: 240 bytes (id=10), snacCommand=YourInfoCmd: UserInfo for 154380033: flags=0x51 (MASK_FREE | MASK_UNCONFIRMED | 0x40), memberSince=Thu Mar 21 14:33:47 CET 2002, sessLenAim=0min, onSince=Wed Nov 15 08:41:31 CET 2006, extraTlvs=[TLV: type=0xc, length=37, ascii value="…
I could not copy&paste the last log message here because it contains some binary data, the message is something like (this is another, similar line):
2006.11.15 09:38:35 OSCAR bos snac response received: SnacResponseEvent: request=SnacRequest for MyInfoRequest: listeners: , responses: null - SnacPacketEvent: snacProcessor=ClientSnacProcessor: lastreqid=13, requests: 13, paused=false, snacPacket=SnacPacket type 0x1/0xf: 240 bytes (id=10), snacCommand=YourInfoCmd: UserInfo for 154380033: flags=0x51 (MASK_FREE | MASK_UNCONFIRMED | 0x40), memberSince=Thu Mar 21 14:33:47 CET 2002, sessLenAim=0min, onSince=Wed Nov 15 09:38:34 CET 2006, extraTlvs=[TLV: type=0xc, length=37, ascii value=" (binary data here) “: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00, TLV: type=0xa, length=4, uint value=3243510804: c1 54 0c 14, TLV: type=0xa, length=4, uint value=3243510804: c1 54 0c 14, TLV: type=0x22, length=2, ushort value=43451: a9 bb, TLV: type=0x1e, length=4, ascii value=” (binary data here) “, uint value=0: 00 00 00 00, TLV: type=0x14, length=1, ascii value=” ": 15] - FlapPacketEvent: flapProcessor=FlapProcessor: seqNum=SeqNum: min=0, max=65535, last(current)=14, flapCommand=SnacFlapCmd: packet=SnacPacket type 0x1/0xf: 240 bytes (id=10), flapPacket=FlapPacket (channel=2, seq=22021)
Then there were some more messages that I did not copy&paste here (I did not notice at first that the binary data cut off the rest of the copy&paste operation).
When I log out and back on, the contact list is ok.
Cheers,
Filip