Ticket #5283 (closed defect: duplicate)
AIM messages are delayed a long time when sent right after signing on
| Reported by: | A88Laptop | Owned by: | nobody |
|---|---|---|---|
| Milestone: | Component: | Service/AIM | |
| Version: | 1.0b9 | Severity: | normal |
| Keywords: | Cc: | mgarrison@… | |
| Patch Status: |
Description
1.0b9 has fixed the rate limiting when signing on with a large buddy list, however, now when I send a message right after I have signed on it takes 4 or 5 minutes for it to actually get sent.
[7:24:24 PM EDT] ClientSnacProcessor: Queueing Snac request #101: SendImIcbm to chok0nothing (id=0, ackr
eq=true): IM: <HTML>can you see this?</HTML>
[7:24:24 PM EDT] RateQueue: Enqueuing SendImIcbm to chok0nothing (id=0, ackreq=true): IM: <HTML>can you
see this?</HTML> within ratequeue (class 3)...
[7:24:24 PM EDT] RateClassMonitor: Class 3 should be waiting 1443ms (avg is 2127ms)
[7:24:24 PM EDT] RateClassMonitor: Class 3 should be waiting 1443ms (avg is 2127ms)
[7:24:24 PM EDT] Conversation: ImConversation: firing outgoing event: net.kano.joustsim.oscar.oscar.service
.icbm.ImMessageInfo@a39121
[7:24:24 PM EDT] ClientSnacProcessor: Queueing Snac request #102: SendTypingNotification from chok0nothi
ng (nulls=0, code=1): no text
[7:24:24 PM EDT] RateQueue: Enqueuing SendTypingNotification from chok0nothing (nulls=0, code=1): no tex
t within ratequeue (class 1)...
[7:24:24 PM EDT] Conversation: ImConversation: firing outgoing event: TypingInfo{NO_TEXT}
[7:24:24 PM EDT] RateClassMonitor: Class 3 should be waiting 1435ms (avg is 2128ms)
[7:24:24 PM EDT] RateClassMonitor: Class 3 should be waiting 1434ms (avg is 2128ms)
[7:24:24 PM EDT] RateClassMonitor: Class 1 should be waiting -263426ms (avg is 4992ms)
[7:24:24 PM EDT] RateClassMonitor: Class 1 should be waiting -263426ms (avg is 4992ms)
[7:24:24 PM EDT] RateQueue: Dequeueing SendTypingNotification from chok0nothing (nulls=0, code=1): no te
xt from ratequeue (class 1)...
Then it's finally sent:
[7:29:04 PM EDT] RateQueue: Dequeueing SendImIcbm to chok0nothing (id=0, ackreq=true): IM: <HTML>can you see this?</HTML> from ratequeue (class 3)... [7:29:04 PM EDT] RateClassMonitor: Class 3 should be waiting -1ms (avg is 2200ms) [7:29:04 PM EDT] RateQueue: sendAndDequeueReadyRequests(): RateQueue: rateMonitor=RateClassMonitor: rateInf o=RateClassInfo for class 3, currentAvg=6000, windowSize=20, clearAvg=3100, warnAvg=2500, limitedAvg=2000, disconnectAvg=1500, max=6000, lastTime=182, currentState=0, families: 6, last=1156202940451, runningAvg=209 0, limited=false, errorMargin=-1, queued: 4 will attempt to send 1 [7:29:04 PM EDT] RateClassMonitor: Class 3 should be waiting -2ms (avg is 2200ms) [7:29:04 PM EDT] ClientSnacProcessor: Sending SNAC request SnacRequest for SendImIcbm to chok0nothing (i d=0, ackreq=true): IM: <HTML>can you see this?</HTML>: listeners: [net.kano.joustsim.oscar.oscar.service.ic bm.ImConversation$2@8cb0d2], responses: null
I can provide more logs, etc if need be.
Change History
Note: See
TracTickets for help on using
tickets.
meh, i need to search better. this is a dupe of #5252