Page 1 of 1

big message delay since icq v6 (adium 1.2.6)

Posted: Thu Jul 03, 2008 8:35 pm
by Michael Kruck
Hello,

since the last update to Adium version 1.2.6 I have a big message delay to all other instant messanger clients e.g. Miranda, ICQ6, Trillian... Furthermore, if i send a message to an offline contact, he got the message for approximately 10 times in a loop as soon as he is online. What should I try to solve the problem?

Another problem I have is (already in earlier versions), if someone wants to send more than one file, which are not zipped, it doesn't work.

I'm using Mac OS X 10.5.4 on a MacBook Pro. Many thanks in advance.

Kindest regards Michael

Re: big message delay since icq v6 (adium 1.2.6)

Posted: Fri Jul 04, 2008 7:40 am
by Michael Kruck
Here you have a cut from the debug log:

09:28:22: (Libpurple: oscar) Sent message to 79518778.
09:28:22: (Libpurple: oscar) Attempting to send 32 queued SNACs for 0x89e3520
09:28:23: (Libpurple: oscar) Attempting to send 32 queued SNACs for 0x89e3520
09:28:23: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:24: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:24: (Libpurple: oscar) Attempting to send 32 queued SNACs for 0x89e3520
09:28:24: (Libpurple: oscar) unknown short capability: {0104}
09:28:24: (Libpurple: oscar) unknown capability: {0138ca7b-769a-4915-88f2-13fc00979ea8}
09:28:24: (Libpurple: oscar) unknown capability: {67361515-612d-4c07-8f3d-bde6408ea041}
09:28:24: (Libpurple: oscar) unknown capability: {1a093c6c-d7fd-4ec5-9d51-a6474e34f5a0}
09:28:24: (Libpurple: oscar) unknown capability: {563fc809-0b6f-41bd-9f79-422609dfa2f3}
09:28:24: (Libpurple: oscar) unknown capability: {b2ec8f16-7c6f-451b-bd79-dc58497888b9}
09:28:24: (Libpurple: oscar) unknown capability: {178c2d9b-daa5-45bb-8ddb-f3bdbd53a10a}
09:28:25: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:25: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:26: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:26: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:27: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:27: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:28: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:28: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:28: (Libpurple: oscar) icq response: 536 bytes, 164031591, 0x07da, 0x0147
09:28:28: (Libpurple: blist) Updating buddy status for 282491092 (ICQ)
09:28:29: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:29: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:30: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:30: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:31: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:31: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:32: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:32: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:33: (Libpurple: oscar) Attempting to send 33 queued SNACs for 0x89e3520
09:28:33: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:34: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:34: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:35: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:35: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:36: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:36: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:37: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:37: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:38: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:38: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:39: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:39: (Libpurple: oscar) unknown capability: {0138ca7b-769a-4915-88f2-13fc00979ea8}
09:28:39: (Libpurple: oscar) unknown capability: {67361515-612d-4c07-8f3d-bde6408ea041}
09:28:39: (Libpurple: oscar) unknown capability: {1a093c6c-d7fd-4ec5-9d51-a6474e34f5a0}
09:28:39: (Libpurple: oscar) unknown capability: {563fc809-0b6f-41bd-9f79-422609dfa2f3}
09:28:39: (Libpurple: oscar) unknown capability: {b2ec8f16-7c6f-451b-bd79-dc58497888b9}
09:28:39: (Libpurple: oscar) unknown capability: {178c2d9b-daa5-45bb-8ddb-f3bdbd53a10a}
09:28:39: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:40: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:40: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:41: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:41: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:42: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:42: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:43: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:43: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:44: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:44: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:45: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:45: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:46: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:46: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:47: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:47: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:48: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:48: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:49: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:49: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:50: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:50: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:51: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:51: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:52: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:52: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:53: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:53: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:54: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:54: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:55: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:55: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:56: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:56: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:57: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:57: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:58: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:58: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:28:59: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:28:59: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:00: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:00: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:01: (Libpurple: oscar) Attempting to send 34 queued SNACs for 0x89e3520
09:29:01: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:02: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:02: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:03: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:03: (Libpurple: oscar) Attempting to send 35 queued SNACs for 0x89e3520
09:29:04: (Libpurple: oscar) unknown short capability: {0104}
09:29:04: (Libpurple: oscar) unknown capability: {0138ca7b-769a-4915-88f2-13fc00979ea8}
09:29:04: (Libpurple: oscar) unknown capability: {67361515-612d-4c07-8f3d-bde6408ea041}
09:29:04: (Libpurple: oscar) unknown capability: {1a093c6c-d7fd-4ec5-9d51-a6474e34f5a0}
09:29:04: (Libpurple: oscar) unknown capability: {563fc809-0b6f-41bd-9f79-422609dfa2f3}
09:29:04: (Libpurple: oscar) unknown capability: {b2ec8f16-7c6f-451b-bd79-dc58497888b9}
09:29:04: (Libpurple: oscar) unknown capability: {178c2d9b-daa5-45bb-8ddb-f3bdbd53a10a}
09:29:04: (Libpurple: oscar) Empty encoding, assuming UTF-8
09:29:04: (Libpurple: blist) Updating buddy status for 277765575 (ICQ)
.
.
.
09:34:21: (Libpurple: oscar) Attempting to send 44 queued SNACs for 0x89e3520
...

I noticed that within the session the queue is rising every minute, if I restart Adium, the queue starts again at 1 and rises up to...

Many Thanks

Re: big message delay since icq v6 (adium 1.2.6)

Posted: Fri Jul 04, 2008 10:43 am
by Michael Kruck
furthermore i noticed that approximately after 20 minutes of running adium the queue goes downwards again, and everything works!!!

no one else the same problem?!?!

Re: big message delay since icq v6 (adium 1.2.6)

Posted: Fri Jul 04, 2008 7:37 pm
by evands
This is because of the support for ICQ Status Notes, which queries all your contacts at login. That code needs to be fixed to do its own throttling so it doesn't interfere with more important things, like messaging. Can you file a ticket with your debug logging please (trac.adiumx.com/wiki/ReportingBugs)?

Re: big message delay since icq v6 (adium 1.2.6)

Posted: Sat Jul 05, 2008 12:33 pm
by Michael Kruck
ok thanks, i have still post a ticket here: http://trac.adiumx.com/ticket/10350

Re: big message delay since icq v6 (adium 1.2.6)

Posted: Fri Jul 18, 2008 8:06 pm
by evands
Please try the test build posted in #10350 and report there as to whether it fixes the issue ASAP :)